See
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4475/display/redirect>
------------------------------------------
[...truncated 25.43 MB...]
3: I1120 03:36:02.311451 19986 process.cpp:3932] Handling HTTP event for
process 'slave(667)' with path: '/slave(667)/api/v1'
3: I1120 03:36:02.312115 19984 process.cpp:3932] Handling HTTP event for
process 'slave(667)' with path: '/slave(667)/api/v1'
3: I1120 03:36:02.312753 19975 process.cpp:3932] Handling HTTP event for
process 'slave(667)' with path: '/slave(667)/api/v1'
3: I1120 03:36:02.315100 19998 http.cpp:1185] HTTP POST for /slave(667)/api/v1
from 172.17.0.2:38546
3: I1120 03:36:02.315572 19998 http.cpp:1185] HTTP POST for /slave(667)/api/v1
from 172.17.0.2:38544
3: I1120 03:36:02.315918 19998 http.cpp:1185] HTTP POST for /slave(667)/api/v1
from 172.17.0.2:38548
3: I1120 03:36:02.316423 19998 http.cpp:2617] Processing WAIT_CONTAINER call
for container
'14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699'
3: I1120 03:36:02.316845 19998 http.cpp:2617] Processing WAIT_CONTAINER call
for container
'14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f'
3: I1120 03:36:02.317201 19998 http.cpp:2781] Processing KILL_CONTAINER call
for container
'14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699'
3: I1120 03:36:02.392089 19981 containerizer.cpp:2705] Container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699
has exited
3: I1120 03:36:02.392150 19981 containerizer.cpp:2254] Destroying container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699
in RUNNING state
3: I1120 03:36:02.392168 19981 containerizer.cpp:2818] Transitioning the state
of container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699
from RUNNING to DESTROYING
3: I1120 03:36:02.392603 19981 launcher.cpp:156] Asked to destroy container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699
3: I1120 03:36:02.397722 19998 provisioner.cpp:490] Ignoring destroy request
for unknown container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f.1ebbcb2b-768a-4e77-8448-7dd17c657699
3: I1120 03:36:02.397917 19998 containerizer.cpp:2543] Checkpointing
termination state to nested container's runtime directory
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_6_1yFJTC/containers/14d81d30-3774-4728-9494-fc2dfe0a9606/containers/c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f/containers/1ebbcb2b-768a-4e77-8448-7dd17c657699/termination'
3: I1120 03:36:02.402465 19982 process.cpp:3932] Handling HTTP event for
process 'slave(667)' with path: '/slave(667)/api/v1'
3: I1120 03:36:02.404183 19983 http.cpp:1185] HTTP POST for /slave(667)/api/v1
from 172.17.0.2:38550
3: I1120 03:36:02.404942 19983 http.cpp:2781] Processing KILL_CONTAINER call
for container
'14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f'
3: I1120 03:36:02.495645 19982 containerizer.cpp:2705] Container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f has
exited
3: I1120 03:36:02.495700 19982 containerizer.cpp:2254] Destroying container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f in
RUNNING state
3: I1120 03:36:02.495724 19982 containerizer.cpp:2818] Transitioning the state
of container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f from
RUNNING to DESTROYING
3: I1120 03:36:02.496219 19982 launcher.cpp:156] Asked to destroy container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f
3: I1120 03:36:02.500115 19998 provisioner.cpp:490] Ignoring destroy request
for unknown container
14d81d30-3774-4728-9494-fc2dfe0a9606.c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f
3: I1120 03:36:02.500380 19998 containerizer.cpp:2543] Checkpointing
termination state to nested container's runtime directory
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_6_1yFJTC/containers/14d81d30-3774-4728-9494-fc2dfe0a9606/containers/c9eab1c8-c2b2-46cf-a5cb-d2368d01f33f/termination'
3: I1120 03:36:02.503924 19985 containerizer.cpp:2254] Destroying container
14d81d30-3774-4728-9494-fc2dfe0a9606 in RUNNING state
3: I1120 03:36:02.503959 19985 containerizer.cpp:2818] Transitioning the state
of container 14d81d30-3774-4728-9494-fc2dfe0a9606 from RUNNING to DESTROYING
3: I1120 03:36:02.504292 19985 launcher.cpp:156] Asked to destroy container
14d81d30-3774-4728-9494-fc2dfe0a9606
3: I1120 03:36:02.529981 19988 slave.cpp:5130] Got exited event for
executor(1)@172.17.0.2:39302
3: I1120 03:36:02.599472 19976 containerizer.cpp:2705] Container
14d81d30-3774-4728-9494-fc2dfe0a9606 has exited
3: I1120 03:36:02.602581 19984 provisioner.cpp:490] Ignoring destroy request
for unknown container 14d81d30-3774-4728-9494-fc2dfe0a9606
3: I1120 03:36:02.604768 19976 slave.cpp:5539] Executor
'318a9bbe-a159-4383-b523-f1afae7e0ffe' of framework
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-0000 terminated with signal Killed
3: I1120 03:36:02.605087 19976 slave.cpp:4517] Handling status update
TASK_FAILED (UUID: c25eb860-bbcf-4def-8749-4c071cb381fb) for task
318a9bbe-a159-4383-b523-f1afae7e0ffe of framework
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-0000 from @0.0.0.0:0
3: W1120 03:36:02.606467 19993 containerizer.cpp:2063] Ignoring update for
unknown container 14d81d30-3774-4728-9494-fc2dfe0a9606
3: I1120 03:36:02.606515 19987 slave.cpp:883] Agent terminating
3: I1120 03:36:02.606876 19983 master.cpp:1309] Agent
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-S0 at slave(667)@172.17.0.2:45197
(4e4be254bc7a) disconnected
3: I1120 03:36:02.606930 19983 master.cpp:3368] Disconnecting agent
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-S0 at slave(667)@172.17.0.2:45197
(4e4be254bc7a)
3: I1120 03:36:02.607069 19983 master.cpp:3387] Deactivating agent
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-S0 at slave(667)@172.17.0.2:45197
(4e4be254bc7a)
3: I1120 03:36:02.607306 19988 hierarchical.cpp:697] Agent
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-S0 deactivated
3: I1120 03:36:02.618897 19974 master.cpp:1151] Master terminating
3: W1120 03:36:02.619091 19974 master.cpp:9582] Removing task
318a9bbe-a159-4383-b523-f1afae7e0ffe with resources
[{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
of framework 4891a4c6-bdc6-4a2d-915a-ac006f4e9080-0000 on agent
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-S0 at slave(667)@172.17.0.2:45197
(4e4be254bc7a) in non-removable state TASK_RUNNING
3: I1120 03:36:02.620060 19995 hierarchical.cpp:633] Removed agent
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-S0
3: I1120 03:36:02.622066 19989 hierarchical.cpp:358] Removed framework
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-0000
3: I1120 03:36:02.626616 19974 sched.cpp:2009] Asked to stop the driver
3: I1120 03:36:02.626883 19980 sched.cpp:1191] Stopping framework
4891a4c6-bdc6-4a2d-915a-ac006f4e9080-0000
3: [ OK ]
ParentChildContainerTypeAndContentType/AgentContainerAPITest.TwoLevelNestedContainerLaunch/6
(813 ms)
3: [ RUN ]
ParentChildContainerTypeAndContentType/AgentContainerAPITest.TwoLevelNestedContainerLaunch/8
3: I1120 03:36:02.635987 19974 cluster.cpp:162] Creating default 'local'
authorizer
3: I1120 03:36:02.640921 19976 master.cpp:448] Master
c50d4068-1b68-4b90-b842-51ff5d5900ad (4e4be254bc7a) started on 172.17.0.2:45197
3: I1120 03:36:02.640957 19976 master.cpp:450] 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/12ERGV/credentials"
--filter_gpu_resources="true" --framework_sorter="drf" --help="false"
--hostname_lookup="true" --http_authenticators="basic"
--http_framework_authenticators="basic" --initialize_driver_logging="true"
--log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO"
--max_agent_ping_timeouts="5" --max_completed_frameworks="50"
--max_completed_tasks_per_framework="1000"
--max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false"
--recovery_agent_removal_limit="100%" --registry="in_memory"
--registry_fetch_timeout="1mins" --registry_gc_interval="15mins"
--registry_max_agent_age="2weeks" --registry_max_agent_count="102400"
--registry_store_timeout="100secs" --registry_strict="false"
--root_submissions="true" --user_sorter="drf" --version="false"
--webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/12ERGV/master"
--zk_session_timeout="10secs"
3: I1120 03:36:02.641468 19976 master.cpp:499] Master only allowing
authenticated frameworks to register
3: I1120 03:36:02.641479 19976 master.cpp:505] Master only allowing
authenticated agents to register
3: I1120 03:36:02.641485 19976 master.cpp:511] Master only allowing
authenticated HTTP frameworks to register
3: I1120 03:36:02.641494 19976 credentials.hpp:37] Loading credentials for
authentication from '/tmp/12ERGV/credentials'
3: I1120 03:36:02.641960 19976 master.cpp:555] Using default 'crammd5'
authenticator
3: I1120 03:36:02.642204 19976 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
3: I1120 03:36:02.642455 19976 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
3: I1120 03:36:02.642655 19976 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
3: I1120 03:36:02.642802 19976 master.cpp:634] Authorization enabled
3: I1120 03:36:02.643055 19996 whitelist_watcher.cpp:77] No whitelist given
3: I1120 03:36:02.643111 19984 hierarchical.cpp:173] Initialized hierarchical
allocator process
3: I1120 03:36:02.647119 19977 master.cpp:2213] Elected as the leading master!
3: I1120 03:36:02.647179 19977 master.cpp:1693] Recovering from registrar
3: I1120 03:36:02.647446 19989 registrar.cpp:347] Recovering registrar
3: I1120 03:36:02.648438 19989 registrar.cpp:391] Successfully fetched the
registry (0B) in 925952ns
3: I1120 03:36:02.648635 19989 registrar.cpp:495] Applied 1 operations in
52430ns; attempting to update the registry
3: I1120 03:36:02.649643 19989 registrar.cpp:552] Successfully updated the
registry in 908032ns
3: I1120 03:36:02.649847 19989 registrar.cpp:424] Successfully recovered
registrar
3: I1120 03:36:02.650498 19986 master.cpp:1806] Recovered 0 agents from the
registry (129B); allowing 10mins for agents to re-register
3: I1120 03:36:02.650682 19994 hierarchical.cpp:211] Skipping recovery of
hierarchical allocator: nothing to recover
3: W1120 03:36:02.658844 19974 process.cpp:3185] Attempted to spawn already
running process files@172.17.0.2:45197
3: I1120 03:36:02.660328 19974 containerizer.cpp:301] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1120 03:36:02.661305 19974 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
3: W1120 03:36:02.661484 19974 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
3: I1120 03:36:02.661525 19974 provisioner.cpp:255] Using default backend 'copy'
3: I1120 03:36:02.664652 19974 cluster.cpp:448] Creating default 'local'
authorizer
3: I1120 03:36:02.668018 19994 slave.cpp:262] Mesos agent started on
(668)@172.17.0.2:45197
3: I1120 03:36:02.668047 19994 slave.cpp:263] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/store/appc"
--authenticate_http_executors="true" --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/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/credential"
--default_role="*" --disallow_sharing_agent_pid_namespace="false"
--disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true"
--docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs"
--docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
--docker_store_dir="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/store/docker"
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume"
--enforce_container_disk_quota="false" --executor_registration_timeout="1mins"
--executor_reregistration_timeout="2secs"
--executor_secret_key="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/executor_secret_key"
--executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/fetch"
--fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
--gc_disk_headroom="0.1" --hadoop_home="" --help="false"
--hostname_lookup="true" --http_command_executor="false"
--http_credentials="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem" --launcher="posix"
--launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150"
--oversubscribed_resources_interval="15secs" --perf_duration="10secs"
--perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
--quiet="false" --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/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e"
--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/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5"
--zk_session_timeout="10secs"
3: I1120 03:36:02.668603 19994 credentials.hpp:86] Loading credential for
authentication from
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/credential'
3: I1120 03:36:02.668823 19994 slave.cpp:295] Agent using credential for:
test-principal
3: I1120 03:36:02.668848 19994 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/http_credentials'
3: I1120 03:36:02.669239 19994 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1120 03:36:02.669404 19994 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1120 03:36:02.669697 19994 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1120 03:36:02.669840 19994 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1120 03:36:02.670111 19994 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readwrite'
3: I1120 03:36:02.670258 19994 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readwrite'
3: I1120 03:36:02.672327 19994 slave.cpp:593] Agent resources:
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1120 03:36:02.672650 19994 slave.cpp:601] Agent attributes: [ ]
3: I1120 03:36:02.672665 19994 slave.cpp:610] Agent hostname: 4e4be254bc7a
3: I1120 03:36:02.672880 19982 status_update_manager.cpp:177] Pausing sending
status updates
3: I1120 03:36:02.674816 19986 state.cpp:64] Recovering state from
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5/meta'
3: I1120 03:36:02.675390 19981 status_update_manager.cpp:203] Recovering status
update manager
3: I1120 03:36:02.675741 19981 containerizer.cpp:662] Recovering containerizer
3: I1120 03:36:02.678185 19998 provisioner.cpp:416] Provisioner recovery
complete
3: I1120 03:36:02.678795 19991 slave.cpp:6441] Finished recovery
3: I1120 03:36:02.679842 19988 status_update_manager.cpp:177] Pausing sending
status updates
3: I1120 03:36:02.679885 19994 slave.cpp:1007] New master detected at
master@172.17.0.2:45197
3: I1120 03:36:02.680007 19994 slave.cpp:1042] Detecting new master
3: I1120 03:36:02.689371 19996 slave.cpp:1069] Authenticating with master
master@172.17.0.2:45197
3: I1120 03:36:02.689469 19996 slave.cpp:1078] Using default CRAM-MD5
authenticatee
3: I1120 03:36:02.689919 19979 authenticatee.cpp:121] Creating new client SASL
connection
3: I1120 03:36:02.690470 19980 master.cpp:8285] Authenticating
slave(668)@172.17.0.2:45197
3: I1120 03:36:02.690654 19987 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(1299)@172.17.0.2:45197
3: I1120 03:36:02.691074 19977 authenticator.cpp:98] Creating new server SASL
connection
3: I1120 03:36:02.691535 19985 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1120 03:36:02.691581 19985 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1120 03:36:02.691762 19985 authenticator.cpp:204] Received SASL
authentication start
3: I1120 03:36:02.691862 19985 authenticator.cpp:326] Authentication requires
more steps
3: I1120 03:36:02.692008 19985 authenticatee.cpp:259] Received SASL
authentication step
3: I1120 03:36:02.692189 19985 authenticator.cpp:232] Received SASL
authentication step
3: I1120 03:36:02.692250 19985 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '4e4be254bc7a' server FQDN: '4e4be254bc7a'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1120 03:36:02.692278 19985 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1120 03:36:02.692342 19985 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1120 03:36:02.692370 19985 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '4e4be254bc7a' server FQDN: '4e4be254bc7a'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1120 03:36:02.692384 19985 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1120 03:36:02.692390 19985 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1120 03:36:02.692410 19985 authenticator.cpp:318] Authentication success
3: I1120 03:36:02.692584 19995 authenticatee.cpp:299] Authentication success
3: I1120 03:36:02.692646 19981 master.cpp:8315] Successfully authenticated
principal 'test-principal' at slave(668)@172.17.0.2:45197
3: I1120 03:36:02.692703 19978 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(1299)@172.17.0.2:45197
3: I1120 03:36:02.692914 19985 slave.cpp:1161] Successfully authenticated with
master master@172.17.0.2:45197
3: I1120 03:36:02.693284 19985 slave.cpp:1682] Will retry registration in
19.464002ms if necessary
3: I1120 03:36:02.693583 19989 master.cpp:6032] Received register agent message
from slave(668)@172.17.0.2:45197 (4e4be254bc7a)
3: I1120 03:36:02.693744 19989 master.cpp:3870] Authorizing agent with
principal 'test-principal'
3: I1120 03:36:02.694331 19982 master.cpp:6092] Authorized registration of
agent at slave(668)@172.17.0.2:45197 (4e4be254bc7a)
3: I1120 03:36:02.694464 19982 master.cpp:6185] Registering agent at
slave(668)@172.17.0.2:45197 (4e4be254bc7a) with id
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0
3: I1120 03:36:02.695057 19992 registrar.cpp:495] Applied 1 operations in
73164ns; attempting to update the registry
3: I1120 03:36:02.695854 19992 registrar.cpp:552] Successfully updated the
registry in 710144ns
3: I1120 03:36:02.696153 19979 master.cpp:6232] Admitted agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a)
3: I1120 03:36:02.696990 19979 master.cpp:6263] Registered agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a) with
[{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1120 03:36:02.697444 19977 slave.cpp:1207] Registered with master
master@172.17.0.2:45197; given agent ID c50d4068-1b68-4b90-b842-51ff5d5900ad-S0
3: I1120 03:36:02.697479 19987 hierarchical.cpp:600] Added agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 (4e4be254bc7a) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
3: I1120 03:36:02.697607 19976 status_update_manager.cpp:184] Resuming sending
status updates
3: I1120 03:36:02.697868 19977 slave.cpp:1227] Checkpointing SlaveInfo to
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5/meta/slaves/c50d4068-1b68-4b90-b842-51ff5d5900ad-S0/slave.info'
3: I1120 03:36:02.697896 19987 hierarchical.cpp:1457] Performed allocation for
1 agents in 197008ns
3: I1120 03:36:02.698453 19977 slave.cpp:1295] Forwarding total oversubscribed
resources {}
3: I1120 03:36:02.698698 19977 master.cpp:7064] Received update of agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a) with total oversubscribed resources {}
3: I1120 03:36:02.698907 19977 master.cpp:7082] Ignoring update on agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a) as it reports no changes
3: I1120 03:36:02.701813 19985 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.704282 19979 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38552
3: I1120 03:36:02.705449 19979 http.cpp:2395] Processing LAUNCH_CONTAINER call
for container 'cdac60de-579d-4d74-b7e3-cfe5915d4be0'
3: I1120 03:36:02.706765 19993 containerizer.cpp:1149] Starting container
cdac60de-579d-4d74-b7e3-cfe5915d4be0
3: I1120 03:36:02.707665 19993 containerizer.cpp:2818] Transitioning the state
of container cdac60de-579d-4d74-b7e3-cfe5915d4be0 from PROVISIONING to PREPARING
3: I1120 03:36:02.712718 19978 containerizer.cpp:1768] Launching
'mesos-containerizer' with flags '--help="false"
--launch_info="{"command":{"shell":true,"value":"sleep
1000"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5\/containers\/cdac60de-579d-4d74-b7e3-cfe5915d4be0"}]},"task_environment":{},"working_directory":"\/tmp\/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5\/containers\/cdac60de-579d-4d74-b7e3-cfe5915d4be0"}"
--pipe_read="14" --pipe_write="15"
--runtime_directory="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0"
--unshare_namespace_mnt="false"'
3: I1120 03:36:02.716922 19978 launcher.cpp:140] Forked child with pid '27463'
for container 'cdac60de-579d-4d74-b7e3-cfe5915d4be0'
3: I1120 03:36:02.717736 19978 containerizer.cpp:2818] Transitioning the state
of container cdac60de-579d-4d74-b7e3-cfe5915d4be0 from PREPARING to ISOLATING
3: I1120 03:36:02.720113 19984 containerizer.cpp:2818] Transitioning the state
of container cdac60de-579d-4d74-b7e3-cfe5915d4be0 from ISOLATING to FETCHING
3: I1120 03:36:02.720465 19993 fetcher.cpp:379] Starting to fetch URIs for
container: cdac60de-579d-4d74-b7e3-cfe5915d4be0, directory:
/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0
3: I1120 03:36:02.721688 19981 containerizer.cpp:2818] Transitioning the state
of container cdac60de-579d-4d74-b7e3-cfe5915d4be0 from FETCHING to RUNNING
3: I1120 03:36:02.726760 19996 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.728937 19984 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38554
3: I1120 03:36:02.729987 19984 http.cpp:2362] Processing
LAUNCH_NESTED_CONTAINER call for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28'
3: I1120 03:36:02.731154 19995 containerizer.cpp:1149] Starting container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28
3: I1120 03:36:02.731782 19995 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 from
PROVISIONING to PREPARING
3: I1120 03:36:02.734855 19989 containerizer.cpp:1768] Launching
'mesos-containerizer' with flags '--help="false"
--launch_info="{"command":{"shell":true,"value":"sleep
100"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5\/containers\/cdac60de-579d-4d74-b7e3-cfe5915d4be0\/containers\/5e0917fd-2467-4d3c-a4c6-77c0a457ff28"}]},"task_environment":{},"working_directory":"\/tmp\/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5\/containers\/cdac60de-579d-4d74-b7e3-cfe5915d4be0\/containers\/5e0917fd-2467-4d3c-a4c6-77c0a457ff28"}"
--pipe_read="14" --pipe_write="15"
--runtime_directory="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0/containers/5e0917fd-2467-4d3c-a4c6-77c0a457ff28"
--unshare_namespace_mnt="false"'
3: I1120 03:36:02.738762 19989 launcher.cpp:140] Forked child with pid '27464'
for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28'
3: I1120 03:36:02.739532 19989 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 from
PREPARING to ISOLATING
3: I1120 03:36:02.740989 19992 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 from
ISOLATING to FETCHING
3: I1120 03:36:02.741309 19996 fetcher.cpp:379] Starting to fetch URIs for
container:
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28,
directory:
/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0/containers/5e0917fd-2467-4d3c-a4c6-77c0a457ff28
3: I1120 03:36:02.742394 19990 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 from
FETCHING to RUNNING
3: I1120 03:36:02.747329 19991 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.749413 19992 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38556
3: I1120 03:36:02.750259 19992 http.cpp:2362] Processing
LAUNCH_NESTED_CONTAINER call for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c'
3: I1120 03:36:02.751454 19985 containerizer.cpp:1149] Starting container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
3: I1120 03:36:02.752053 19985 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
from PROVISIONING to PREPARING
3: I1120 03:36:02.754994 19977 containerizer.cpp:1768] Launching
'mesos-containerizer' with flags '--help="false"
--launch_info="{"command":{"shell":true,"value":"sleep
100"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5\/containers\/cdac60de-579d-4d74-b7e3-cfe5915d4be0\/containers\/5e0917fd-2467-4d3c-a4c6-77c0a457ff28\/containers\/1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c"}]},"task_environment":{},"working_directory":"\/tmp\/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5\/containers\/cdac60de-579d-4d74-b7e3-cfe5915d4be0\/containers\/5e0917fd-2467-4d3c-a4c6-77c0a457ff28\/containers\/1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c"}"
--pipe_read="14" --pipe_write="15"
--runtime_directory="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0/containers/5e0917fd-2467-4d3c-a4c6-77c0a457ff28/containers/1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c"
--unshare_namespace_mnt="false"'
3: I1120 03:36:02.758009 19977 launcher.cpp:140] Forked child with pid '27465'
for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c'
3: I1120 03:36:02.758803 19977 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
from PREPARING to ISOLATING
3: I1120 03:36:02.760172 19977 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
from ISOLATING to FETCHING
3: I1120 03:36:02.760434 19991 fetcher.cpp:379] Starting to fetch URIs for
container:
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c,
directory:
/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_BiHCn5/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0/containers/5e0917fd-2467-4d3c-a4c6-77c0a457ff28/containers/1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
3: I1120 03:36:02.761483 19994 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
from FETCHING to RUNNING
3: I1120 03:36:02.765905 19993 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.767304 19977 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.767963 19977 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.769413 19988 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38558
3: I1120 03:36:02.770042 19988 http.cpp:2589] Processing WAIT_NESTED_CONTAINER
call for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28'
3: I1120 03:36:02.770516 19988 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38562
3: I1120 03:36:02.770850 19988 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38560
3: I1120 03:36:02.771616 19988 http.cpp:2747] Processing KILL_NESTED_CONTAINER
call for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c'
3: I1120 03:36:02.772061 19988 http.cpp:2589] Processing WAIT_NESTED_CONTAINER
call for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c'
3: I1120 03:36:02.805927 19979 containerizer.cpp:2705] Container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
has exited
3: I1120 03:36:02.805990 19979 containerizer.cpp:2254] Destroying container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
in RUNNING state
3: I1120 03:36:02.806010 19979 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
from RUNNING to DESTROYING
3: I1120 03:36:02.806426 19979 launcher.cpp:156] Asked to destroy container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
3: I1120 03:36:02.810109 19976 provisioner.cpp:490] Ignoring destroy request
for unknown container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28.1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c
3: I1120 03:36:02.810385 19998 containerizer.cpp:2543] Checkpointing
termination state to nested container's runtime directory
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0/containers/5e0917fd-2467-4d3c-a4c6-77c0a457ff28/containers/1f3a501c-b05c-4a1c-a5f0-a9c8b78a8c3c/termination'
3: I1120 03:36:02.815309 19990 process.cpp:3932] Handling HTTP event for
process 'slave(668)' with path: '/slave(668)/api/v1'
3: I1120 03:36:02.816896 19976 http.cpp:1185] HTTP POST for /slave(668)/api/v1
from 172.17.0.2:38564
3: I1120 03:36:02.817627 19976 http.cpp:2747] Processing KILL_NESTED_CONTAINER
call for container
'cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28'
3: I1120 03:36:02.907420 19984 containerizer.cpp:2705] Container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 has
exited
3: I1120 03:36:02.907454 19984 containerizer.cpp:2254] Destroying container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 in
RUNNING state
3: I1120 03:36:02.907469 19984 containerizer.cpp:2818] Transitioning the state
of container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28 from
RUNNING to DESTROYING
3: I1120 03:36:02.907752 19984 launcher.cpp:156] Asked to destroy container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28
3: I1120 03:36:02.911283 19995 provisioner.cpp:490] Ignoring destroy request
for unknown container
cdac60de-579d-4d74-b7e3-cfe5915d4be0.5e0917fd-2467-4d3c-a4c6-77c0a457ff28
3: I1120 03:36:02.911468 19995 containerizer.cpp:2543] Checkpointing
termination state to nested container's runtime directory
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_8_rCwp4e/containers/cdac60de-579d-4d74-b7e3-cfe5915d4be0/containers/5e0917fd-2467-4d3c-a4c6-77c0a457ff28/termination'
3: I1120 03:36:02.915096 19998 containerizer.cpp:2254] Destroying container
cdac60de-579d-4d74-b7e3-cfe5915d4be0 in RUNNING state
3: I1120 03:36:02.915119 19998 containerizer.cpp:2818] Transitioning the state
of container cdac60de-579d-4d74-b7e3-cfe5915d4be0 from RUNNING to DESTROYING
3: I1120 03:36:02.915518 19998 launcher.cpp:156] Asked to destroy container
cdac60de-579d-4d74-b7e3-cfe5915d4be0
3: I1120 03:36:03.009352 19976 containerizer.cpp:2705] Container
cdac60de-579d-4d74-b7e3-cfe5915d4be0 has exited
3: I1120 03:36:03.012063 19993 provisioner.cpp:490] Ignoring destroy request
for unknown container cdac60de-579d-4d74-b7e3-cfe5915d4be0
3: I1120 03:36:03.015163 19974 slave.cpp:883] Agent terminating
3: I1120 03:36:03.015463 19979 master.cpp:1309] Agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a) disconnected
3: I1120 03:36:03.015496 19979 master.cpp:3368] Disconnecting agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a)
3: I1120 03:36:03.015557 19979 master.cpp:3387] Deactivating agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 at slave(668)@172.17.0.2:45197
(4e4be254bc7a)
3: I1120 03:36:03.015707 19981 hierarchical.cpp:697] Agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0 deactivated
3: I1120 03:36:03.024101 19974 master.cpp:1151] Master terminating
3: I1120 03:36:03.024869 19987 hierarchical.cpp:633] Removed agent
c50d4068-1b68-4b90-b842-51ff5d5900ad-S0
3: [ OK ]
ParentChildContainerTypeAndContentType/AgentContainerAPITest.TwoLevelNestedContainerLaunch/8
(397 ms)
3: [ RUN ]
ParentChildContainerTypeAndContentType/AgentContainerAPITest.TwoLevelNestedContainerLaunch/10
3: I1120 03:36:03.035190 19974 cluster.cpp:162] Creating default 'local'
authorizer
3: I1120 03:36:03.039520 19987 master.cpp:448] Master
59ce2c0b-3452-4a56-b6ca-73f2be3b4142 (4e4be254bc7a) started on 172.17.0.2:45197
3: I1120 03:36:03.039553 19987 master.cpp:450] 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/fcoXHa/credentials"
--filter_gpu_resources="true" --framework_sorter="drf" --help="false"
--hostname_lookup="true" --http_authenticators="basic"
--http_framework_authenticators="basic" --initialize_driver_logging="true"
--log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO"
--max_agent_ping_timeouts="5" --max_completed_frameworks="50"
--max_completed_tasks_per_framework="1000"
--max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false"
--recovery_agent_removal_limit="100%" --registry="in_memory"
--registry_fetch_timeout="1mins" --registry_gc_interval="15mins"
--registry_max_agent_age="2weeks" --registry_max_agent_count="102400"
--registry_store_timeout="100secs" --registry_strict="false"
--root_submissions="true" --user_sorter="drf" --version="false"
--webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/fcoXHa/master"
--zk_session_timeout="10secs"
3: I1120 03:36:03.040048 19987 master.cpp:499] Master only allowing
authenticated frameworks to register
3: I1120 03:36:03.040060 19987 master.cpp:505] Master only allowing
authenticated agents to register
3: I1120 03:36:03.040067 19987 master.cpp:511] Master only allowing
authenticated HTTP frameworks to register
3: I1120 03:36:03.040074 19987 credentials.hpp:37] Loading credentials for
authentication from '/tmp/fcoXHa/credentials'
3: I1120 03:36:03.040580 19987 master.cpp:555] Using default 'crammd5'
authenticator
3: I1120 03:36:03.040829 19987 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
3: I1120 03:36:03.041151 19987 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
3: I1120 03:36:03.041329 19987 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
3: I1120 03:36:03.041491 19987 master.cpp:634] Authorization enabled
3: I1120 03:36:03.041698 19976 hierarchical.cpp:173] Initialized hierarchical
allocator process
3: I1120 03:36:03.041716 19995 whitelist_watcher.cpp:77] No whitelist given
3: I1120 03:36:03.044862 19991 master.cpp:2213] Elected as the leading master!
3: I1120 03:36:03.044898 19991 master.cpp:1693] Recovering from registrar
3: I1120 03:36:03.045140 19988 registrar.cpp:347] Recovering registrar
3: I1120 03:36:03.045791 19988 registrar.cpp:391] Successfully fetched the
registry (0B) in 609024ns
3: I1120 03:36:03.045905 19988 registrar.cpp:495] Applied 1 operations in
32936ns; attempting to update the registry
3: I1120 03:36:03.046512 19988 registrar.cpp:552] Successfully updated the
registry in 547072ns
3: I1120 03:36:03.046636 19988 registrar.cpp:424] Successfully recovered
registrar
3: I1120 03:36:03.047086 19979 master.cpp:1806] Recovered 0 agents from the
registry (129B); allowing 10mins for agents to re-register
3: I1120 03:36:03.047148 19975 hierarchical.cpp:211] Skipping recovery of
hierarchical allocator: nothing to recover
3: W1120 03:36:03.052655 19974 process.cpp:3185] Attempted to spawn already
running process files@172.17.0.2:45197
3: I1120 03:36:03.053716 19974 containerizer.cpp:301] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1120 03:36:03.054311 19974 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
3: W1120 03:36:03.054435 19974 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
3: I1120 03:36:03.054469 19974 provisioner.cpp:255] Using default backend 'copy'
3: I1120 03:36:03.056465 19974 cluster.cpp:448] Creating default 'local'
authorizer
3: I1120 03:36:03.058773 19975 slave.cpp:262] Mesos agent started on
(669)@172.17.0.2:45197
3: I1120 03:36:03.058794 19975 slave.cpp:263] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/store/appc"
--authenticate_http_executors="true" --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/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/credential"
--default_role="*" --disallow_sharing_agent_pid_namespace="false"
--disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true"
--docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs"
--docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
--docker_store_dir="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/store/docker"
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume"
--enforce_container_disk_quota="false" --executor_registration_timeout="1mins"
--executor_reregistration_timeout="2secs"
--executor_secret_key="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/executor_secret_key"
--executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/fetch"
--fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
--gc_disk_headroom="0.1" --hadoop_home="" --help="false"
--hostname_lookup="true" --http_command_executor="false"
--http_credentials="/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/http_credentials"
--http_heartbeat_interval="30secs" --initialize_driver_logging="true"
--isolation="posix/cpu,posix/mem" --launcher="posix"
--launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO"
--max_completed_executors_per_framework="150"
--oversubscribed_resources_interval="15secs" --perf_duration="10secs"
--perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
--quiet="false" --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/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv"
--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/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_hOVzll"
--zk_session_timeout="10secs"
3: I1120 03:36:03.059365 19975 credentials.hpp:86] Loading credential for
authentication from
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/credential'
3: I1120 03:36:03.059571 19975 slave.cpp:295] Agent using credential for:
test-principal
3: I1120 03:36:03.059608 19975 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/ParentChildContainerTypeAndContentType_AgentContainerAPITest_TwoLevelNestedContainerLaunch_10_18ydZv/http_credentials'
3: I1120 03:36:03.060000 19975 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1120 03:36:03.060158 19975 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1120 03:36:03.060469 19975 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
write /dev/stdout: resource temporarily unavailable
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user benjamin.hind...@gmail.com
