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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)&&(!ubuntu-eu2)/3036/>
------------------------------------------ [...truncated 158393 lines...] I1214 12:17:06.317922 26077 master.cpp:1097] Master terminating I1214 12:17:06.318145 26084 hierarchical.cpp:522] Removed agent c5a445b2-f410-44a8-ae99-873a1bf5373a-S0 [ OK ] ContentType/AgentAPIStreamingTest.AttachContainerInput/1 (404 ms) [ RUN ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/0 I1214 12:17:06.322159 26077 cluster.cpp:160] Creating default 'local' authorizer I1214 12:17:06.322940 26083 master.cpp:380] Master fdae9f67-b2ab-4931-abbc-d2b2409fb63d (0e87e383821b) started on 172.17.0.2:33804 I1214 12:17:06.322959 26083 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/zdj0FP/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/zdj0FP/master" --zk_session_timeout="10secs" I1214 12:17:06.323143 26083 master.cpp:432] Master only allowing authenticated frameworks to register I1214 12:17:06.323150 26083 master.cpp:446] Master only allowing authenticated agents to register I1214 12:17:06.323154 26083 master.cpp:459] Master only allowing authenticated HTTP frameworks to register I1214 12:17:06.323161 26083 credentials.hpp:37] Loading credentials for authentication from '/tmp/zdj0FP/credentials' I1214 12:17:06.323318 26083 master.cpp:504] Using default 'crammd5' authenticator I1214 12:17:06.323369 26083 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1214 12:17:06.323421 26083 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1214 12:17:06.323465 26083 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1214 12:17:06.323498 26083 master.cpp:584] Authorization enabled I1214 12:17:06.323582 26079 hierarchical.cpp:149] Initialized hierarchical allocator process I1214 12:17:06.323587 26081 whitelist_watcher.cpp:77] No whitelist given I1214 12:17:06.324288 26084 master.cpp:2045] Elected as the leading master! I1214 12:17:06.324303 26084 master.cpp:1568] Recovering from registrar I1214 12:17:06.324350 26080 registrar.cpp:329] Recovering registrar I1214 12:17:06.324582 26078 registrar.cpp:362] Successfully fetched the registry (0B) in 177152ns I1214 12:17:06.324625 26078 registrar.cpp:461] Applied 1 operations in 6330ns; attempting to update the registry I1214 12:17:06.324867 26093 registrar.cpp:506] Successfully updated the registry in 209152ns I1214 12:17:06.324913 26093 registrar.cpp:392] Successfully recovered registrar I1214 12:17:06.325055 26082 master.cpp:1684] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1214 12:17:06.325088 26081 hierarchical.cpp:176] Skipping recovery of hierarchical allocator: nothing to recover I1214 12:17:06.326138 26077 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni W1214 12:17:06.326449 26077 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos W1214 12:17:06.326529 26077 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I1214 12:17:06.327850 26077 cluster.cpp:446] Creating default 'local' authorizer I1214 12:17:06.328243 26082 slave.cpp:209] Mesos agent started on (580)@172.17.0.2:33804 I1214 12:17:06.328259 26082 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_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT/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_AttachInputToNestedContainerSession_0_ruRCwT/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_AttachInputToNestedContainerSession_0_ruRCwT/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_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT" --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_AttachInputToNestedContainerSession_0_Yq9iBm" I1214 12:17:06.328599 26082 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT/credential' I1214 12:17:06.328718 26082 slave.cpp:352] Agent using credential for: test-principal I1214 12:17:06.328734 26082 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT/http_credentials' I1214 12:17:06.328799 26077 sched.cpp:232] Version: 1.2.0 I1214 12:17:06.328877 26082 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I1214 12:17:06.328932 26082 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I1214 12:17:06.329015 26078 sched.cpp:336] New master detected at [email protected]:33804 I1214 12:17:06.329046 26078 sched.cpp:402] Authenticating with master [email protected]:33804 I1214 12:17:06.329057 26078 sched.cpp:409] Using default CRAM-MD5 authenticatee I1214 12:17:06.329190 26085 authenticatee.cpp:121] Creating new client SASL connection I1214 12:17:06.329355 26092 master.cpp:6748] Authenticating [email protected]:33804 I1214 12:17:06.329407 26085 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1128)@172.17.0.2:33804 I1214 12:17:06.329529 26092 authenticator.cpp:98] Creating new server SASL connection I1214 12:17:06.329510 26082 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I1214 12:17:06.329560 26082 slave.cpp:547] Agent attributes: [ ] I1214 12:17:06.329567 26082 slave.cpp:552] Agent hostname: 0e87e383821b I1214 12:17:06.329666 26090 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1214 12:17:06.329744 26090 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1214 12:17:06.329836 26090 authenticator.cpp:204] Received SASL authentication start I1214 12:17:06.329885 26090 authenticator.cpp:326] Authentication requires more steps I1214 12:17:06.329948 26080 state.cpp:57] Recovering state from '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/meta' I1214 12:17:06.330004 26090 authenticatee.cpp:259] Received SASL authentication step I1214 12:17:06.330081 26080 status_update_manager.cpp:203] Recovering status update manager I1214 12:17:06.330083 26092 authenticator.cpp:232] Received SASL authentication step I1214 12:17:06.330114 26092 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0e87e383821b' server FQDN: '0e87e383821b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1214 12:17:06.330129 26092 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1214 12:17:06.330170 26078 containerizer.cpp:594] Recovering containerizer I1214 12:17:06.330186 26092 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1214 12:17:06.330209 26092 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0e87e383821b' server FQDN: '0e87e383821b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1214 12:17:06.330221 26092 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1214 12:17:06.330230 26092 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1214 12:17:06.330247 26092 authenticator.cpp:318] Authentication success I1214 12:17:06.330296 26079 authenticatee.cpp:299] Authentication success I1214 12:17:06.330468 26089 master.cpp:6778] Successfully authenticated principal 'test-principal' at [email protected]:33804 I1214 12:17:06.330602 26087 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1128)@172.17.0.2:33804 I1214 12:17:06.330620 26080 sched.cpp:508] Successfully authenticated with master [email protected]:33804 I1214 12:17:06.330667 26080 sched.cpp:826] Sending SUBSCRIBE call to [email protected]:33804 I1214 12:17:06.330714 26080 sched.cpp:859] Will retry registration in 994.057173ms if necessary I1214 12:17:06.330770 26088 provisioner.cpp:253] Provisioner recovery complete I1214 12:17:06.330772 26082 master.cpp:2633] Received SUBSCRIBE call for framework 'default' at [email protected]:33804 I1214 12:17:06.330857 26082 master.cpp:2081] Authorizing framework principal 'test-principal' to receive offers for role '*' I1214 12:17:06.330957 26079 slave.cpp:5420] Finished recovery I1214 12:17:06.330994 26089 master.cpp:2709] Subscribing framework default with checkpointing disabled and capabilities [ ] I1214 12:17:06.331151 26084 hierarchical.cpp:276] Added framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.331174 26084 hierarchical.cpp:1689] No allocations performed I1214 12:17:06.331182 26084 hierarchical.cpp:1784] No inverse offers to send out! I1214 12:17:06.331193 26084 hierarchical.cpp:1291] Performed allocation for 0 agents in 26386ns I1214 12:17:06.331238 26081 sched.cpp:749] Framework registered with fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.331291 26081 sched.cpp:763] Scheduler::registered took 34003ns I1214 12:17:06.331379 26079 slave.cpp:5594] Querying resource estimator for oversubscribable resources I1214 12:17:06.331462 26079 slave.cpp:924] New master detected at [email protected]:33804 I1214 12:17:06.331470 26083 status_update_manager.cpp:177] Pausing sending status updates I1214 12:17:06.331483 26079 slave.cpp:983] Authenticating with master [email protected]:33804 I1214 12:17:06.331503 26079 slave.cpp:994] Using default CRAM-MD5 authenticatee I1214 12:17:06.331543 26079 slave.cpp:956] Detecting new master I1214 12:17:06.331562 26088 authenticatee.cpp:121] Creating new client SASL connection I1214 12:17:06.331614 26079 slave.cpp:5608] Received oversubscribable resources {} from the resource estimator I1214 12:17:06.331696 26083 master.cpp:6748] Authenticating slave(580)@172.17.0.2:33804 I1214 12:17:06.331743 26088 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1129)@172.17.0.2:33804 I1214 12:17:06.331799 26079 authenticator.cpp:98] Creating new server SASL connection I1214 12:17:06.331920 26080 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I1214 12:17:06.331943 26080 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I1214 12:17:06.331982 26080 authenticator.cpp:204] Received SASL authentication start I1214 12:17:06.332041 26080 authenticator.cpp:326] Authentication requires more steps I1214 12:17:06.332096 26086 authenticatee.cpp:259] Received SASL authentication step I1214 12:17:06.332173 26089 authenticator.cpp:232] Received SASL authentication step I1214 12:17:06.332195 26089 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0e87e383821b' server FQDN: '0e87e383821b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I1214 12:17:06.332224 26089 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I1214 12:17:06.332242 26089 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I1214 12:17:06.332259 26089 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0e87e383821b' server FQDN: '0e87e383821b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I1214 12:17:06.332273 26089 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I1214 12:17:06.332283 26089 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I1214 12:17:06.332301 26089 authenticator.cpp:318] Authentication success I1214 12:17:06.332351 26080 authenticatee.cpp:299] Authentication success I1214 12:17:06.332373 26082 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1129)@172.17.0.2:33804 I1214 12:17:06.332432 26089 master.cpp:6778] Successfully authenticated principal 'test-principal' at slave(580)@172.17.0.2:33804 I1214 12:17:06.332486 26085 slave.cpp:1078] Successfully authenticated with master [email protected]:33804 I1214 12:17:06.332576 26085 slave.cpp:1492] Will retry registration in 13.134799ms if necessary I1214 12:17:06.332695 26089 master.cpp:5161] Registering agent at slave(580)@172.17.0.2:33804 (0e87e383821b) with id fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 I1214 12:17:06.332821 26083 registrar.cpp:461] Applied 1 operations in 16764ns; attempting to update the registry I1214 12:17:06.333147 26092 registrar.cpp:506] Successfully updated the registry in 303104ns I1214 12:17:06.333371 26091 slave.cpp:4272] Received ping from slave-observer(528)@172.17.0.2:33804 I1214 12:17:06.333389 26090 master.cpp:5232] Registered agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I1214 12:17:06.333433 26091 slave.cpp:1124] Registered with master [email protected]:33804; given agent ID fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 I1214 12:17:06.333451 26091 fetcher.cpp:90] Clearing fetcher cache I1214 12:17:06.333473 26080 hierarchical.cpp:490] Added agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 (0e87e383821b) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I1214 12:17:06.333535 26084 status_update_manager.cpp:184] Resuming sending status updates I1214 12:17:06.333744 26091 slave.cpp:1147] Checkpointing SlaveInfo to '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/meta/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/slave.info' I1214 12:17:06.333751 26080 hierarchical.cpp:1784] No inverse offers to send out! I1214 12:17:06.333792 26080 hierarchical.cpp:1314] Performed allocation for agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 in 286406ns I1214 12:17:06.333887 26088 master.cpp:6577] Sending 1 offers to framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 I1214 12:17:06.333968 26091 slave.cpp:1184] Forwarding total oversubscribed resources {} I1214 12:17:06.334059 26088 master.cpp:5633] Received update of agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) with total oversubscribed resources {} I1214 12:17:06.334075 26083 sched.cpp:923] Scheduler::resourceOffers took 49496ns I1214 12:17:06.334178 26080 hierarchical.cpp:560] Agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 (0e87e383821b) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]) I1214 12:17:06.334239 26080 hierarchical.cpp:1689] No allocations performed I1214 12:17:06.334250 26080 hierarchical.cpp:1784] No inverse offers to send out! I1214 12:17:06.334259 26080 hierarchical.cpp:1314] Performed allocation for agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 in 42049ns I1214 12:17:06.334569 26086 master.cpp:3588] Processing ACCEPT call for offers: [ fdae9f67-b2ab-4931-abbc-d2b2409fb63d-O0 ] on agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) for framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 I1214 12:17:06.334604 26086 master.cpp:3175] Authorizing framework principal 'test-principal' to launch task d22e2924-fdc7-49f0-bfb8-dbda84937d3b I1214 12:17:06.335062 26080 master.cpp:8501] Adding task d22e2924-fdc7-49f0-bfb8-dbda84937d3b with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 (0e87e383821b) I1214 12:17:06.335135 26080 master.cpp:4240] Launching task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) I1214 12:17:06.335377 26093 slave.cpp:1556] Got assigned task 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' for framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.335613 26093 slave.cpp:1718] Launching task 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' for framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.336036 26093 paths.cpp:530] Trying to chown '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8' to user 'mesos' I1214 12:17:06.342546 26093 slave.cpp:6347] Launching executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 with resources cpus(*):0.1; mem(*):32 in work directory '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8' I1214 12:17:06.342870 26093 slave.cpp:2040] Queued task 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' for executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.342876 26091 containerizer.cpp:986] Starting container 39f28aff-35ef-482d-a49a-6d2b8b1935f8 for executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.342923 26093 slave.cpp:877] Successfully attached file '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8' I1214 12:17:06.344396 26079 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.2:33804"},{"name":"MESOS_CHECKPOINT","value":"0"},{"name":"MESOS_DIRECTORY","value":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm\/slaves\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0\/frameworks\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000\/executors\/d22e2924-fdc7-49f0-bfb8-dbda84937d3b\/runs\/39f28aff-35ef-482d-a49a-6d2b8b1935f8"},{"name":"MESOS_EXECUTOR_ID","value":"d22e2924-fdc7-49f0-bfb8-dbda84937d3b"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","value":"fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","value":"0"},{"name":"MESOS_SLAVE_ID","value":"fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0"},{"name":"MESOS_SLAVE_PID","value":"slave(580)@172.17.0.2:33804"},{"name":"MESOS_SANDBOX","value":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm\/slaves\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0\/frameworks\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000\/executors\/d22e2924-fdc7-49f0-bfb8-dbda84937d3b\/runs\/39f28aff-35ef-482d-a49a-6d2b8b1935f8"}]},"err":{"path":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm\/slaves\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0\/frameworks\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000\/executors\/d22e2924-fdc7-49f0-bfb8-dbda84937d3b\/runs\/39f28aff-35ef-482d-a49a-6d2b8b1935f8\/stderr","type":"PATH"},"out":{"path":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm\/slaves\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0\/frameworks\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000\/executors\/d22e2924-fdc7-49f0-bfb8-dbda84937d3b\/runs\/39f28aff-35ef-482d-a49a-6d2b8b1935f8\/stdout","type":"PATH"},"user":"mesos","working_directory":"\/tmp\/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm\/slaves\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0\/frameworks\/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000\/executors\/d22e2924-fdc7-49f0-bfb8-dbda84937d3b\/runs\/39f28aff-35ef-482d-a49a-6d2b8b1935f8"}" --pipe_read="9" --pipe_write="10" --runtime_directory="/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT/containers/39f28aff-35ef-482d-a49a-6d2b8b1935f8" --unshare_namespace_mnt="false"' I1214 12:17:06.346454 26079 launcher.cpp:133] Forked child with pid '30205' for container '39f28aff-35ef-482d-a49a-6d2b8b1935f8' I1214 12:17:06.348260 26090 fetcher.cpp:349] Starting to fetch URIs for container: 39f28aff-35ef-482d-a49a-6d2b8b1935f8, directory: /tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8 I1214 12:17:06.439666 26089 slave.cpp:3314] Got registration for executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 from executor(1)@172.17.0.2:48542 I1214 12:17:06.440549 26080 slave.cpp:2256] Sending queued task 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' to executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 at executor(1)@172.17.0.2:48542 I1214 12:17:06.446043 26082 slave.cpp:3749] Handling status update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 from executor(1)@172.17.0.2:48542 I1214 12:17:06.446607 26080 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.446684 26080 status_update_manager.cpp:500] Creating StatusUpdate stream for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.446841 26080 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 to the agent I1214 12:17:06.446938 26085 slave.cpp:4190] Forwarding the update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 to [email protected]:33804 I1214 12:17:06.447065 26085 slave.cpp:4084] Status update manager successfully handled status update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.447072 26080 master.cpp:5769] Status update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 from agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) I1214 12:17:06.447098 26080 master.cpp:5831] Forwarding status update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.447090 26085 slave.cpp:4100] Sending acknowledgement for status update TASK_RUNNING (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 to executor(1)@172.17.0.2:48542 I1214 12:17:06.447166 26080 master.cpp:7867] Updating the state of task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I1214 12:17:06.447307 26080 sched.cpp:1031] Scheduler::statusUpdate took 69692ns I1214 12:17:06.447496 26083 master.cpp:4877] Processing ACKNOWLEDGE call 1aa82594-d69a-4c65-b36d-5574f7b5c1e6 for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 on agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 I1214 12:17:06.448088 26089 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.448271 26086 process.cpp:3679] Handling HTTP event for process 'slave(580)' with path: '/slave(580)/api/v1' I1214 12:17:06.448422 26086 slave.cpp:3031] Status update manager successfully handled status update acknowledgement (UUID: 1aa82594-d69a-4c65-b36d-5574f7b5c1e6) for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.448626 26085 http.cpp:301] HTTP POST for /slave(580)/api/v1 from 172.17.0.2:60883 I1214 12:17:06.448753 26085 http.cpp:462] Processing call LAUNCH_NESTED_CONTAINER_SESSION I1214 12:17:06.448933 26086 containerizer.cpp:1802] Starting nested container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.449234 26086 containerizer.cpp:1826] Trying to chown '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8/containers/9a724aec-4583-46ae-8c8a-95e29f4ec26b' to user 'mesos' I1214 12:17:06.459038 26083 switchboard.cpp:567] Launching 'mesos-io-switchboard' with flags '--heartbeat_interval="30secs" --help="false" --socket_address="/tmp/mesos-io-switchboard-a75c98b4-f952-4a6d-a78d-dc409952eade" --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="true"' for container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.461079 26083 switchboard.cpp:597] Created I/O switchboard server (pid: 30226) listening on socket file '/tmp/mesos-io-switchboard-a75c98b4-f952-4a6d-a78d-dc409952eade' for container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.462311 26090 containerizer.cpp:1535] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"shell":true,"value":"cat"},"environment":{},"err":{"fd":18,"type":"FD"},"in":{"fd":13,"type":"FD"},"out":{"fd":16,"type":"FD"},"user":"mesos"}" --pipe_read="14" --pipe_write="15" --runtime_directory="/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT/containers/39f28aff-35ef-482d-a49a-6d2b8b1935f8/containers/9a724aec-4583-46ae-8c8a-95e29f4ec26b" --unshare_namespace_mnt="false"' I1214 12:17:06.464215 26090 launcher.cpp:133] Forked child with pid '30227' for container '39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b' I1214 12:17:06.465795 26081 fetcher.cpp:349] Starting to fetch URIs for container: 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b, directory: /tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8/containers/9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.535574 26088 process.cpp:3679] Handling HTTP event for process 'slave(580)' with path: '/slave(580)/api/v1' I1214 12:17:06.535962 26088 http.cpp:301] HTTP POST for /slave(580)/api/v1 from 172.17.0.2:60884 I1214 12:17:06.538485 26089 http.cpp:462] Processing call ATTACH_CONTAINER_INPUT **** DEADLOCK DETECTED! **** You are waiting on process __limiter__(604)@172.17.0.2:33804 that it is currently executing. I1214 12:17:06.665621 26082 http.cpp:2708] Received EOF attach response for 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.665791 26082 containerizer.cpp:2113] Destroying container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b in RUNNING state I1214 12:17:06.665989 26082 launcher.cpp:149] Asked to destroy container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b W1214 12:17:06.667085 26091 http.cpp:2723] Launch nested container session connection for container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b closed I1214 12:17:06.696760 26093 master.cpp:1305] Framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 disconnected I1214 12:17:06.696812 26093 master.cpp:2918] Disconnecting framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 I1214 12:17:06.696830 26093 master.cpp:2942] Deactivating framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 I1214 12:17:06.696859 26093 master.cpp:1318] Giving framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 0ns to failover I1214 12:17:06.696995 26085 hierarchical.cpp:391] Deactivated framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.697114 26087 master.cpp:6429] Framework failover timeout, removing framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 I1214 12:17:06.697167 26087 master.cpp:7299] Removing framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (default) at [email protected]:33804 I1214 12:17:06.697350 26087 master.cpp:7867] Updating the state of task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I1214 12:17:06.697521 26092 containerizer.cpp:2113] Destroying container 39f28aff-35ef-482d-a49a-6d2b8b1935f8 in RUNNING state I1214 12:17:06.697589 26087 master.cpp:7963] Removing task d22e2924-fdc7-49f0-bfb8-dbda84937d3b with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 on agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) I1214 12:17:06.697757 26090 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 fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 from framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.697819 26089 slave.cpp:2584] Asked to shut down framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 by [email protected]:33804 I1214 12:17:06.697846 26089 slave.cpp:2609] Shutting down framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.697860 26089 slave.cpp:4999] Shutting down executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 at executor(1)@172.17.0.2:48542 I1214 12:17:06.697886 26090 hierarchical.cpp:342] Removed framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.721261 26087 switchboard.cpp:855] I/O switchboard server process for container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b has terminated (status=0) I1214 12:17:06.721592 26087 containerizer.cpp:2476] Container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b has exited I1214 12:17:06.722375 26091 provisioner.cpp:324] Ignoring destroy request for unknown container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.722856 26088 containerizer.cpp:2392] Checkpointing termination state to nested container's runtime directory '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_ruRCwT/containers/39f28aff-35ef-482d-a49a-6d2b8b1935f8/containers/9a724aec-4583-46ae-8c8a-95e29f4ec26b/termination' I1214 12:17:06.723392 26088 launcher.cpp:149] Asked to destroy container 39f28aff-35ef-482d-a49a-6d2b8b1935f8 I1214 12:17:06.730896 26090 slave.cpp:4318] Got exited event for executor(1)@172.17.0.2:48542 I1214 12:17:06.823451 26091 containerizer.cpp:2476] Container 39f28aff-35ef-482d-a49a-6d2b8b1935f8 has exited I1214 12:17:06.824398 26084 provisioner.cpp:324] Ignoring destroy request for unknown container 39f28aff-35ef-482d-a49a-6d2b8b1935f8 I1214 12:17:06.825472 26090 slave.cpp:4681] Executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 terminated with signal Killed I1214 12:17:06.825510 26090 slave.cpp:4785] Cleaning up executor 'd22e2924-fdc7-49f0-bfb8-dbda84937d3b' of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 at executor(1)@172.17.0.2:48542 I1214 12:17:06.825712 26083 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b/runs/39f28aff-35ef-482d-a49a-6d2b8b1935f8' for gc 6.99999044376296days in the future I1214 12:17:06.825881 26090 slave.cpp:4873] Cleaning up framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 W1214 12:17:06.825911 26089 containerizer.cpp:2101] Attempted to destroy unknown container 39f28aff-35ef-482d-a49a-6d2b8b1935f8.9a724aec-4583-46ae-8c8a-95e29f4ec26b I1214 12:17:06.825999 26081 status_update_manager.cpp:285] Closing status update streams for framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.826020 26081 status_update_manager.cpp:531] Cleaning up status update stream for task d22e2924-fdc7-49f0-bfb8-dbda84937d3b of framework fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000 I1214 12:17:06.826103 26082 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000/executors/d22e2924-fdc7-49f0-bfb8-dbda84937d3b' for gc 6.99999044248889days in the future I1214 12:17:06.826172 26082 gc.cpp:55] Scheduling '/tmp/ContentType_AgentAPIStreamingTest_AttachInputToNestedContainerSession_0_Yq9iBm/slaves/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0/frameworks/fdae9f67-b2ab-4931-abbc-d2b2409fb63d-0000' for gc 6.99999043993185days in the future I1214 12:17:06.826254 26077 slave.cpp:796] Agent terminating I1214 12:17:06.826329 26081 master.cpp:1258] Agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) disconnected I1214 12:17:06.826352 26081 master.cpp:2977] Disconnecting agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) I1214 12:17:06.826390 26081 master.cpp:2996] Deactivating agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 at slave(580)@172.17.0.2:33804 (0e87e383821b) I1214 12:17:06.826460 26084 hierarchical.cpp:589] Agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 deactivated I1214 12:17:06.828490 26077 master.cpp:1097] Master terminating I1214 12:17:06.828711 26088 hierarchical.cpp:522] Removed agent fdae9f67-b2ab-4931-abbc-d2b2409fb63d-S0 [ OK ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/0 (509 ms) [ RUN ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/1 I1214 12:17:06.832954 26077 cluster.cpp:160] Creating default 'local' authorizer I1214 12:17:06.833727 26082 master.cpp:380] Master 77329cc0-b471-494d-9b4a-ffdf2729f4ff (0e87e383821b) started on 172.17.0.2:33804 I1214 12:17:06.833799 26082 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/HxtMIJ/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/HxtMIJ/master" --zk_session_timeout="10secs" I1214 12:17:06.833959 26082 master.cpp:432] Master only allowing authenticated frameworks to register I1214 12:17:06.833966 26082 master.cpp:446] Master only allowing authenticated agents to register I1214 12:17:06.833971 26082 master.cpp:459] Master only allowing authenticated HTTP frameworks to register I1214 12:17:06.833976 26082 credentials.hpp:37] Loading credentials for authentication from '/tmp/HxtMIJ/credentials' I1214 12:17:06.834077 26082 master.cpp:504] Using default 'crammd5' authenticator I1214 12:17:06.834118 26082 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I1214 12:17:06.834164 26082 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I1214 12:17:06.834210 26082 http.cpp:922] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I1214 12:17:06.834245 26082 master.cpp:584] Authorization enabled I1214 12:17:06.834331 26083 whitelist_watcher.cpp:77] No whitelist given I1214 12:17:06.834343 26089 hierarchical.cpp:149] Initialized hierarchical allocator process I1214 12:17:06.834880 26082 master.cpp:2045] Elected as the leading master! I1214 12:17:06.834892 26082 master.cpp:1568] Recovering from registrar I1214 12:17:06.834954 26090 registrar.cpp:329] Recovering registrar I1214 12:17:06.835155 26089 registrar.cpp:362] Successfully fetched the registry (0B) in 176896ns I1214 12:17:06.835203 26089 registrar.cpp:461] Applied 1 operations in 4811ns; attempting to update the registry I1214 12:17:06.835566 26093 registrar.cpp:506] Successfully updated the registry in 326912ns I1214 12:17:06.835608 26093 registrar.cpp:392] Successfully recovered registrar I1214 12:17:06.835731 26082 master.cpp:1684] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I1214 12:17:06.835845 26092 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-1481715032-11277 Error response from daemon: conflict: unable to remove repository reference "mesos-1481715032-11277" (must force) - container 0e87e383821b is using its referenced image d4d089d6b602
