You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/08/15 08:28:05 UTC
Build failed in Jenkins: Mesos-Reviewbot #18875
See <https://builds.apache.org/job/Mesos-Reviewbot/18875/display/redirect>
------------------------------------------
[...truncated 31.01 MB...]
I0815 08:27:59.035521 5273 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.035552 5273 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xaDHfn/http_credentials'
I0815 08:27:59.036077 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.036511 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.038868 5273 slave.cpp:565] 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"}]
I0815 08:27:59.039297 5273 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.039330 5273 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.039744 5271 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.042085 5268 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_1RFImG/meta'
I0815 08:27:59.042752 5274 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.043094 5272 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.045574 5272 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.046376 5271 slave.cpp:6210] Finished recovery
I0815 08:27:59.047302 5271 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.048005 5271 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.052500 5271 process.cpp:3933] Handling HTTP event for process 'slave(799)' with path: '/slave(799)/containers'
I0815 08:27:59.055017 5267 http.cpp:1166] HTTP GET for /slave(799)/containers from 172.17.0.2:52496
I0815 08:27:59.055142 5267 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 08:27:59.061200 5273 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (50 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0815 08:27:59.078621 5248 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 08:27:59.079424 5248 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 08:27:59.079638 5248 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 08:27:59.079689 5248 provisioner.cpp:255] Using default backend 'copy'
I0815 08:27:59.085518 5272 slave.cpp:250] Mesos agent started on (800)@172.17.0.2:33225
I0815 08:27:59.085561 5272 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_vRpHes"
I0815 08:27:59.086436 5272 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/credential'
I0815 08:27:59.086757 5272 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.086792 5272 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PrjZf9/http_credentials'
I0815 08:27:59.087263 5272 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.087612 5272 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.089942 5272 slave.cpp:565] 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"}]
I0815 08:27:59.090373 5272 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.090392 5272 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.090796 5267 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.092862 5273 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_vRpHes/meta'
I0815 08:27:59.093314 5267 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.093791 5268 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.096441 5268 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.097182 5267 slave.cpp:6210] Finished recovery
I0815 08:27:59.097878 5267 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.098479 5273 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.102536 5273 process.cpp:3933] Handling HTTP event for process 'slave(800)' with path: '/slave(800)/monitor/statistics'
I0815 08:27:59.104776 5270 http.cpp:1166] HTTP GET for /slave(800)/monitor/statistics from 172.17.0.2:52498
I0815 08:27:59.104964 5270 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0815 08:27:59.109045 5248 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (55 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0815 08:27:59.134116 5248 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 08:27:59.134896 5248 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 08:27:59.135100 5248 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 08:27:59.135146 5248 provisioner.cpp:255] Using default backend 'copy'
I0815 08:27:59.140813 5269 slave.cpp:250] Mesos agent started on (801)@172.17.0.2:33225
I0815 08:27:59.140854 5269 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_97X9Ee"
I0815 08:27:59.141917 5269 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/credential'
I0815 08:27:59.142496 5269 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.142534 5269 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_rLlrPV/http_credentials'
I0815 08:27:59.143182 5269 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.143728 5269 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.146595 5269 slave.cpp:565] 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"}]
I0815 08:27:59.147029 5269 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.147059 5269 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.147598 5274 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.150058 5273 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_97X9Ee/meta'
I0815 08:27:59.150743 5274 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.151099 5270 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.153164 5268 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.154008 5274 slave.cpp:6210] Finished recovery
I0815 08:27:59.154666 5274 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.155148 5271 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.159615 5270 process.cpp:3933] Handling HTTP event for process 'slave(801)' with path: '/slave(801)/monitor/statistics.json'
I0815 08:27:59.161681 5271 http.cpp:1166] HTTP GET for /slave(801)/monitor/statistics.json from 172.17.0.2:52500
I0815 08:27:59.161875 5271 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0815 08:27:59.166407 5248 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (49 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0815 08:27:59.184547 5248 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 08:27:59.185356 5248 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 08:27:59.185570 5248 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 08:27:59.185616 5248 provisioner.cpp:255] Using default backend 'copy'
I0815 08:27:59.191359 5273 slave.cpp:250] Mesos agent started on (802)@172.17.0.2:33225
I0815 08:27:59.191402 5273 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_ZA98D1"
I0815 08:27:59.192505 5273 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/credential'
I0815 08:27:59.193017 5273 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.193049 5273 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_nTOAWI/http_credentials'
I0815 08:27:59.193598 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.194026 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.196431 5273 slave.cpp:565] 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"}]
I0815 08:27:59.196861 5273 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.196884 5273 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.197329 5272 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.199638 5274 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_ZA98D1/meta'
I0815 08:27:59.200494 5271 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.201015 5268 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.203253 5268 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.203969 5272 slave.cpp:6210] Finished recovery
I0815 08:27:59.204661 5272 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.205082 5273 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.209707 5269 process.cpp:3933] Handling HTTP event for process 'slave(802)' with path: '/slave(802)/containers'
I0815 08:27:59.212278 5267 http.cpp:1166] HTTP GET for /slave(802)/containers from 172.17.0.2:52502
I0815 08:27:59.212401 5267 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 08:27:59.216511 5267 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (49 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0815 08:27:59.242018 5248 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 08:27:59.242820 5248 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 08:27:59.243034 5248 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 08:27:59.243086 5248 provisioner.cpp:255] Using default backend 'copy'
I0815 08:27:59.245928 5248 cluster.cpp:448] Creating default 'local' authorizer
I0815 08:27:59.249047 5273 slave.cpp:250] Mesos agent started on (803)@172.17.0.2:33225
I0815 08:27:59.249092 5273 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_fXwq9O"
I0815 08:27:59.249997 5273 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/credential'
I0815 08:27:59.250495 5273 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.250536 5273 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_peBSzw/http_credentials'
I0815 08:27:59.251067 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.251610 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.254019 5273 slave.cpp:565] 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"}]
I0815 08:27:59.254451 5273 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.254473 5273 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.254984 5269 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.257374 5268 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_fXwq9O/meta'
I0815 08:27:59.258002 5272 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.258462 5268 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.260681 5267 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.261548 5267 slave.cpp:6210] Finished recovery
I0815 08:27:59.262341 5267 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.262805 5268 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.267112 5269 process.cpp:3933] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/monitor/statistics'
I0815 08:27:59.269706 5268 http.cpp:1166] HTTP GET for /slave(803)/monitor/statistics from 172.17.0.2:52504
I0815 08:27:59.270022 5268 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0815 08:27:59.275779 5248 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (59 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0815 08:27:59.293895 5248 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 08:27:59.294690 5248 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 08:27:59.294900 5248 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 08:27:59.294950 5248 provisioner.cpp:255] Using default backend 'copy'
I0815 08:27:59.297772 5248 cluster.cpp:448] Creating default 'local' authorizer
I0815 08:27:59.300961 5274 slave.cpp:250] Mesos agent started on (804)@172.17.0.2:33225
I0815 08:27:59.301002 5274 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_NOjifD"
I0815 08:27:59.301853 5274 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/credential'
I0815 08:27:59.302158 5274 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.302186 5274 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_HVImPk/http_credentials'
I0815 08:27:59.302620 5274 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.302952 5274 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.305243 5274 slave.cpp:565] 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"}]
I0815 08:27:59.305739 5274 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.305785 5274 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.306213 5271 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.308132 5270 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_NOjifD/meta'
I0815 08:27:59.308665 5267 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.309145 5274 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.311579 5271 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.312381 5270 slave.cpp:6210] Finished recovery
I0815 08:27:59.313057 5270 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.313704 5267 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.318214 5267 process.cpp:3933] Handling HTTP event for process 'slave(804)' with path: '/slave(804)/monitor/statistics.json'
I0815 08:27:59.320394 5270 http.cpp:1166] HTTP GET for /slave(804)/monitor/statistics.json from 172.17.0.2:52506
I0815 08:27:59.320559 5270 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0815 08:27:59.326836 5248 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (50 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0815 08:27:59.344900 5248 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 08:27:59.345700 5248 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 08:27:59.345916 5248 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 08:27:59.345963 5248 provisioner.cpp:255] Using default backend 'copy'
I0815 08:27:59.348754 5248 cluster.cpp:448] Creating default 'local' authorizer
I0815 08:27:59.351883 5270 slave.cpp:250] Mesos agent started on (805)@172.17.0.2:33225
I0815 08:27:59.351954 5270 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bVUvTr"
I0815 08:27:59.352726 5270 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/credential'
I0815 08:27:59.353025 5270 slave.cpp:283] Agent using credential for: test-principal
I0815 08:27:59.353090 5270 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_rRiQB9/http_credentials'
I0815 08:27:59.353531 5270 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 08:27:59.353875 5270 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 08:27:59.356148 5270 slave.cpp:565] 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"}]
I0815 08:27:59.356655 5270 slave.cpp:573] Agent attributes: [ ]
I0815 08:27:59.356703 5270 slave.cpp:582] Agent hostname: 8284b6a9a070
I0815 08:27:59.357118 5271 status_update_manager.cpp:177] Pausing sending status updates
I0815 08:27:59.359028 5269 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bVUvTr/meta'
I0815 08:27:59.359704 5274 status_update_manager.cpp:203] Recovering status update manager
I0815 08:27:59.359951 5268 containerizer.cpp:598] Recovering containerizer
I0815 08:27:59.362409 5268 provisioner.cpp:416] Provisioner recovery complete
I0815 08:27:59.362979 5267 slave.cpp:6210] Finished recovery
I0815 08:27:59.363759 5267 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 08:27:59.364486 5271 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 08:27:59.369084 5269 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/containers'
I0815 08:27:59.371240 5270 http.cpp:1166] HTTP GET for /slave(805)/containers from 172.17.0.2:52508
I0815 08:27:59.371403 5270 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 08:27:59.377900 5248 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (50 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (510 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (18 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (19 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (37 ms total)
[----------] Global test environment tear-down
[==========] 1655 tests from 182 test cases ran. (780336 ms total)
[ PASSED ] 1651 tests.
[ FAILED ] 4 tests, listed below:
[ FAILED ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckStatusChange
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask
4 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
I0815 08:27:59.561177 5275 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502778280-27645
Untagged: mesos-1502778280-27645:latest
Deleted: sha256:0aaf65f2d23c2057b39ab6f4fe59b9c98d2574f5e966c5bc3471450c16afb0d9
Deleted: sha256:dfa8cb9ba262f96dce5642469ddc4da64d2551b3316df2b39701d7cad9df5566
Deleted: sha256:a89320f03d76f76e77ec95f0202ba3bd8e1c4c0ea978bee72cb45c162f1b4c2f
Deleted: sha256:b7db451c2d53f1e92d172ef5362847408035d54c4c511f1d67f2c2737ac562fc
Deleted: sha256:0206a3305a8abfeaf939e9a0f00780925fd481d7c5b23449cf63e37311b96ba4
Deleted: sha256:2af24fbe710d8c4cdf4400f4de2d2d66e15aa1e796b9894f590e6ac64567e5b3
Deleted: sha256:7235f88ca35340f0bf6057a39b995d065fa42298052fd5fa8e32999fc69bbfb9
Deleted: sha256:a794e1c31536a79618daa2ce4b672e3dd6936bc237bf4562c8ef5e5576d61fd6
Deleted: sha256:77e0a33d1717319d974493599a0b2121ccd14dbc2e2716e4810ebfe027a2d04d
Deleted: sha256:998b3fcc6cebd9e6a639608a166be41e84546db47ffd71cdf97123baeb2a07fd
Deleted: sha256:a9fe931220dc1a3181962e46a34a8b83ab72b312962924023b8717398fdeedb3
Deleted: sha256:4f56bda68b5271dfca4dc08986ce9ad8cf9081d434f4e64f34d583c5ca43b4db
Deleted: sha256:0d65c124725a3c25012dd084da115ec16bba3518a9f2af4ea513d767015cb144
Deleted: sha256:1c7b86240bf8209058474997b39fcaa115fa63b622db5b233917324001950142
Deleted: sha256:11d602c1809297be5cf04d0fae97e8fb816637f0b40e14ae5ae4f17be6eeeef7
Deleted: sha256:4591b22c2a2d1001e055c9615daa43c070f3c6d3b1d16f47dc9ef3eb2011fe4e
Deleted: sha256:ab49517b7d98b0e8ec1e27a83b14d6bde1727d322d688f91439c4cf8e8c595f9
Deleted: sha256:fb33033e089e2c34e945eb35d286a9765f9852d6463df38891ed72a9a65e460d
Deleted: sha256:d54ef4e65ace44da4428d3c1c94f18f682de940a5ebcd722131290515033e89a
Deleted: sha256:3581cc74102212e045c7365f9269b6b51be59101dc02499deaed04e19d4c4b60
Deleted: sha256:56f99f140d55b6dec3559896105133ce431a5a3629e3b592be30ebec82581880
Deleted: sha256:98c1b6e8f94e7d79c94770a5bad51cb9e6535429de8753679768657631a6a199
Deleted: sha256:9d90c371d26d2c8b9c059a6bc30933692fab2d7308018e980e1920c581b0ed6f
Deleted: sha256:c022ef75a106fe40d3bf77fdebce18478efd5d5e781f830b9a9212566557f372
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Reviewbot #18881
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18881/display/redirect>
Build failed in Jenkins: Mesos-Reviewbot #18880
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18880/display/redirect>
------------------------------------------
[URLTrigger] A change within the response URL invocation (log)
[EnvInject] - Loading node environment variables.
Building remotely on H21 (couchdbtest ubuntu xenial) in workspace <https://builds.apache.org/job/Mesos-Reviewbot/ws/>
Cloning the remote Git repository
Cloning repository https://git-wip-us.apache.org/repos/asf/mesos.git
> git init <https://builds.apache.org/job/Mesos-Reviewbot/ws/> # timeout=10
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/mesos.git
> git --version # timeout=10
> git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/mesos.git +refs/heads/*:refs/remotes/origin/*
> git config remote.origin.url https://git-wip-us.apache.org/repos/asf/mesos.git # timeout=10
> git config --add remote.origin.fetch +refs/heads/*:refs/remotes/origin/* # timeout=10
> git config remote.origin.url https://git-wip-us.apache.org/repos/asf/mesos.git # timeout=10
Fetching upstream changes from https://git-wip-us.apache.org/repos/asf/mesos.git
> git fetch --tags --progress https://git-wip-us.apache.org/repos/asf/mesos.git +refs/heads/*:refs/remotes/origin/*
> git rev-parse origin/master^{commit} # timeout=10
Checking out Revision e335106aa0406210a5faa10d5657701ca6fbb80c (origin/master)
Commit message: "Moved MESOS-7660 to the appropriate CHANGELOG section."
> git config core.sparsecheckout # timeout=10
> git checkout -f e335106aa0406210a5faa10d5657701ca6fbb80c
> git rev-list e335106aa0406210a5faa10d5657701ca6fbb80c # timeout=10
> git tag -a -f -m Jenkins Build #18880 jenkins-Mesos-Reviewbot-18880 # timeout=10
[EnvInject] - Executing scripts and injecting environment variables after the SCM step.
[EnvInject] - Injecting as environment variables the properties content
USERNAME=mesos-review
[EnvInject] - Variables injected successfully.
[EnvInject] - Mask passwords that will be passed as build parameters.
FATAL: Unable to produce a script file
java.io.IOException: Permission denied
at java.io.UnixFileSystem.createFileExclusively(Native Method)
at java.io.File.createTempFile(File.java:2024)
at hudson.FilePath$17.invoke(FilePath.java:1373)
at hudson.FilePath$17.invoke(FilePath.java:1363)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2739)
at hudson.remoting.UserRequest.perform(UserRequest.java:153)
at hudson.remoting.UserRequest.perform(UserRequest.java:50)
at hudson.remoting.Request$2.run(Request.java:336)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.io.IOException: Failed to create a temporary directory in /tmp
at hudson.FilePath$17.invoke(FilePath.java:1375)
at hudson.FilePath$17.invoke(FilePath.java:1363)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2739)
at hudson.remoting.UserRequest.perform(UserRequest.java:153)
at hudson.remoting.UserRequest.perform(UserRequest.java:50)
at hudson.remoting.Request$2.run(Request.java:336)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
at ......remote call to H21(Native Method)
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1545)
at hudson.remoting.UserResponse.retrieve(UserRequest.java:253)
at hudson.remoting.Channel.call(Channel.java:830)
at hudson.FilePath.act(FilePath.java:986)
Caused: java.io.IOException: remote file operation failed: <https://builds.apache.org/job/Mesos-Reviewbot/ws/> at hudson.remoting.Channel@4b715ff3:H21
at hudson.FilePath.act(FilePath.java:993)
at hudson.FilePath.act(FilePath.java:975)
at hudson.FilePath.createTextTempFile(FilePath.java:1363)
Caused: java.io.IOException: Failed to create a temp file on <https://builds.apache.org/job/Mesos-Reviewbot/ws/>
at hudson.FilePath.createTextTempFile(FilePath.java:1386)
at hudson.tasks.CommandInterpreter.createScriptFile(CommandInterpreter.java:162)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:94)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:735)
at hudson.model.Build$BuildExecution.build(Build.java:206)
at hudson.model.Build$BuildExecution.doRun(Build.java:163)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:490)
at hudson.model.Run.execute(Run.java:1735)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:405)
Build step 'Execute shell' marked build as failure
Build failed in Jenkins: Mesos-Reviewbot #18879
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18879/display/redirect?page=changes>
Changes:
[alexr] Added entry for 1.5.0 to CHANGELOG.
[alexr] Moved MESOS-7660 to the appropriate CHANGELOG section.
------------------------------------------
[...truncated 23.82 MB...]
I0815 17:30:13.644903 5263 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:13.644975 5266 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:13.646183 5265 replica.cpp:694] Replica received learned notice for position 1 from log-network(89)@172.17.0.2:46055
I0815 17:30:13.646510 5264 replica.cpp:694] Replica received learned notice for position 1 from log-network(89)@172.17.0.2:46055
I0815 17:30:13.694777 5265 leveldb.cpp:341] Persisting action (68 bytes) to leveldb took 48.521462ms
I0815 17:30:13.694849 5265 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:13.694793 5264 leveldb.cpp:341] Persisting action (68 bytes) to leveldb took 48.176924ms
I0815 17:30:13.694975 5264 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:13.696609 5270 log.cpp:579] Attempting to truncate the log to 1
I0815 17:30:13.697016 5268 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0815 17:30:13.698361 5263 replica.cpp:540] Replica received write request for position 2 from __req_res__(1628)@172.17.0.2:46055
I0815 17:30:13.698395 5266 replica.cpp:540] Replica received write request for position 2 from __req_res__(1629)@172.17.0.2:46055
I0815 17:30:13.744961 5266 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 46.412795ms
I0815 17:30:13.744957 5263 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 46.29597ms
I0815 17:30:13.745091 5266 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:13.745293 5263 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:13.746381 5268 replica.cpp:694] Replica received learned notice for position 2 from log-network(89)@172.17.0.2:46055
I0815 17:30:13.746562 5264 replica.cpp:694] Replica received learned notice for position 2 from log-network(89)@172.17.0.2:46055
I0815 17:30:13.794800 5264 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 48.125744ms
I0815 17:30:13.794801 5268 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 48.343393ms
I0815 17:30:13.795013 5264 leveldb.cpp:399] Deleting ~1 keys from leveldb took 99862ns
I0815 17:30:13.795204 5268 leveldb.cpp:399] Deleting ~1 keys from leveldb took 142981ns
I0815 17:30:13.795308 5268 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:13.795419 5264 replica.cpp:711] Persisted action TRUNCATE at position 2
[ OK ] LogStateTest.FetchAndStoreAndStoreFailAndFetch (429 ms)
[ RUN ] LogStateTest.FetchAndStoreAndExpungeAndFetch
I0815 17:30:13.811851 5244 leveldb.cpp:174] Opened db in 9.610978ms
I0815 17:30:13.814700 5244 leveldb.cpp:181] Compacted db in 2.765793ms
I0815 17:30:13.814815 5244 leveldb.cpp:196] Created db iterator in 31249ns
I0815 17:30:13.814841 5244 leveldb.cpp:202] Seeked to beginning of db in 3189ns
I0815 17:30:13.814862 5244 leveldb.cpp:271] Iterated through 0 keys in the db in 632ns
I0815 17:30:13.814923 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:13.817647 5264 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.161951ms
I0815 17:30:13.817744 5264 replica.cpp:322] Persisted replica status to VOTING
I0815 17:30:13.828716 5244 leveldb.cpp:174] Opened db in 10.012431ms
I0815 17:30:13.831588 5244 leveldb.cpp:181] Compacted db in 2.786425ms
I0815 17:30:13.831701 5244 leveldb.cpp:196] Created db iterator in 31309ns
I0815 17:30:13.831727 5244 leveldb.cpp:202] Seeked to beginning of db in 3097ns
I0815 17:30:13.831749 5244 leveldb.cpp:271] Iterated through 0 keys in the db in 531ns
I0815 17:30:13.831812 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:13.834623 5266 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.262354ms
I0815 17:30:13.834720 5266 replica.cpp:322] Persisted replica status to VOTING
I0815 17:30:13.845448 5244 leveldb.cpp:174] Opened db in 9.732025ms
I0815 17:30:13.852723 5244 leveldb.cpp:181] Compacted db in 7.190357ms
I0815 17:30:13.852846 5244 leveldb.cpp:196] Created db iterator in 41555ns
I0815 17:30:13.852910 5244 leveldb.cpp:202] Seeked to beginning of db in 40282ns
I0815 17:30:13.852980 5244 leveldb.cpp:271] Iterated through 1 keys in the db in 46678ns
I0815 17:30:13.853041 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:13.862804 5244 leveldb.cpp:174] Opened db in 9.397039ms
I0815 17:30:13.870784 5244 leveldb.cpp:181] Compacted db in 7.894642ms
I0815 17:30:13.870908 5244 leveldb.cpp:196] Created db iterator in 42036ns
I0815 17:30:13.870971 5244 leveldb.cpp:202] Seeked to beginning of db in 39680ns
I0815 17:30:13.871040 5244 leveldb.cpp:271] Iterated through 1 keys in the db in 46427ns
I0815 17:30:13.871103 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:13.872222 5263 recover.cpp:451] Starting replica recovery
I0815 17:30:13.872833 5263 recover.cpp:477] Replica is in VOTING status
I0815 17:30:13.873242 5263 recover.cpp:466] Recover process terminated
I0815 17:30:13.873915 5266 log.cpp:536] Attempting to start the writer
I0815 17:30:13.875635 5270 replica.cpp:496] Replica received implicit promise request from __req_res__(1630)@172.17.0.2:46055 with proposal 1
I0815 17:30:13.875679 5269 replica.cpp:496] Replica received implicit promise request from __req_res__(1631)@172.17.0.2:46055 with proposal 1
I0815 17:30:13.878294 5269 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.546229ms
I0815 17:30:13.878355 5269 replica.cpp:344] Persisted promised to 1
I0815 17:30:13.878315 5270 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.601759ms
I0815 17:30:13.878731 5270 replica.cpp:344] Persisted promised to 1
I0815 17:30:13.879565 5264 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0815 17:30:13.881470 5264 replica.cpp:391] Replica received explicit promise request from __req_res__(1632)@172.17.0.2:46055 for position 0 with proposal 2
I0815 17:30:13.881525 5270 replica.cpp:391] Replica received explicit promise request from __req_res__(1633)@172.17.0.2:46055 for position 0 with proposal 2
I0815 17:30:13.924960 5264 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 43.365554ms
I0815 17:30:13.925076 5264 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:13.924957 5270 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 42.955761ms
I0815 17:30:13.925420 5270 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:13.927240 5266 replica.cpp:540] Replica received write request for position 0 from __req_res__(1634)@172.17.0.2:46055
I0815 17:30:13.927243 5267 replica.cpp:540] Replica received write request for position 0 from __req_res__(1635)@172.17.0.2:46055
I0815 17:30:13.927534 5266 leveldb.cpp:436] Reading position from leveldb took 188555ns
I0815 17:30:13.927762 5267 leveldb.cpp:436] Reading position from leveldb took 178620ns
I0815 17:30:13.976405 5266 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 48.740764ms
I0815 17:30:13.976599 5266 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:13.976425 5267 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 48.585082ms
I0815 17:30:13.976882 5267 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:13.978060 5264 replica.cpp:694] Replica received learned notice for position 0 from log-network(90)@172.17.0.2:46055
I0815 17:30:13.978085 5263 replica.cpp:694] Replica received learned notice for position 0 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.025033 5263 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 46.69234ms
I0815 17:30:14.025044 5264 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 46.847642ms
I0815 17:30:14.025202 5264 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.025115 5263 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.026271 5269 log.cpp:552] Writer started with ending position 0
I0815 17:30:14.029619 5269 leveldb.cpp:436] Reading position from leveldb took 95290ns
I0815 17:30:14.031873 5269 log.cpp:560] Attempting to append 49 bytes to the log
I0815 17:30:14.032122 5265 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0815 17:30:14.033413 5268 replica.cpp:540] Replica received write request for position 1 from __req_res__(1637)@172.17.0.2:46055
I0815 17:30:14.033427 5266 replica.cpp:540] Replica received write request for position 1 from __req_res__(1636)@172.17.0.2:46055
I0815 17:30:14.084756 5266 leveldb.cpp:341] Persisting action (65 bytes) to leveldb took 51.20208ms
I0815 17:30:14.084782 5268 leveldb.cpp:341] Persisting action (65 bytes) to leveldb took 51.283415ms
I0815 17:30:14.084885 5266 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:14.084923 5268 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:14.085842 5265 replica.cpp:694] Replica received learned notice for position 1 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.086156 5263 replica.cpp:694] Replica received learned notice for position 1 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.134857 5265 leveldb.cpp:341] Persisting action (67 bytes) to leveldb took 48.948519ms
I0815 17:30:14.134876 5263 leveldb.cpp:341] Persisting action (67 bytes) to leveldb took 48.627499ms
I0815 17:30:14.134937 5265 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:14.134956 5263 replica.cpp:711] Persisted action APPEND at position 1
I0815 17:30:14.137470 5263 log.cpp:579] Attempting to truncate the log to 1
I0815 17:30:14.137843 5265 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0815 17:30:14.139243 5266 replica.cpp:540] Replica received write request for position 2 from __req_res__(1638)@172.17.0.2:46055
I0815 17:30:14.139734 5270 replica.cpp:540] Replica received write request for position 2 from __req_res__(1639)@172.17.0.2:46055
I0815 17:30:14.185042 5270 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 45.219907ms
I0815 17:30:14.185070 5266 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 45.696028ms
I0815 17:30:14.185325 5266 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:14.185117 5270 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:14.186529 5263 replica.cpp:694] Replica received learned notice for position 2 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.186607 5267 replica.cpp:694] Replica received learned notice for position 2 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.227109 5267 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 40.411638ms
I0815 17:30:14.227119 5263 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 40.515118ms
I0815 17:30:14.227257 5263 leveldb.cpp:399] Deleting ~1 keys from leveldb took 68582ns
I0815 17:30:14.227244 5267 leveldb.cpp:399] Deleting ~1 keys from leveldb took 66818ns
I0815 17:30:14.227300 5267 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:14.227289 5263 replica.cpp:711] Persisted action TRUNCATE at position 2
I0815 17:30:14.228852 5270 log.cpp:560] Attempting to append 12 bytes to the log
I0815 17:30:14.229110 5269 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 3
I0815 17:30:14.230450 5270 replica.cpp:540] Replica received write request for position 3 from __req_res__(1640)@172.17.0.2:46055
I0815 17:30:14.230661 5264 replica.cpp:540] Replica received write request for position 3 from __req_res__(1641)@172.17.0.2:46055
I0815 17:30:14.275025 5270 leveldb.cpp:341] Persisting action (28 bytes) to leveldb took 44.478139ms
I0815 17:30:14.275105 5270 replica.cpp:711] Persisted action APPEND at position 3
I0815 17:30:14.275048 5264 leveldb.cpp:341] Persisting action (28 bytes) to leveldb took 44.215316ms
I0815 17:30:14.275329 5264 replica.cpp:711] Persisted action APPEND at position 3
I0815 17:30:14.276273 5263 replica.cpp:694] Replica received learned notice for position 3 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.276451 5265 replica.cpp:694] Replica received learned notice for position 3 from log-network(90)@172.17.0.2:46055
I0815 17:30:14.324997 5265 leveldb.cpp:341] Persisting action (30 bytes) to leveldb took 48.429639ms
I0815 17:30:14.325017 5263 leveldb.cpp:341] Persisting action (30 bytes) to leveldb took 48.672461ms
I0815 17:30:14.325073 5265 replica.cpp:711] Persisted action APPEND at position 3
I0815 17:30:14.325093 5263 replica.cpp:711] Persisted action APPEND at position 3
[ OK ] LogStateTest.FetchAndStoreAndExpungeAndFetch (529 ms)
[ RUN ] LogStateTest.FetchAndStoreAndExpungeAndExpunge
I0815 17:30:14.340595 5244 leveldb.cpp:174] Opened db in 9.27787ms
I0815 17:30:14.343452 5244 leveldb.cpp:181] Compacted db in 2.774946ms
I0815 17:30:14.343564 5244 leveldb.cpp:196] Created db iterator in 30747ns
I0815 17:30:14.343593 5244 leveldb.cpp:202] Seeked to beginning of db in 3348ns
I0815 17:30:14.343616 5244 leveldb.cpp:271] Iterated through 0 keys in the db in 542ns
I0815 17:30:14.343677 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:14.346745 5263 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.422928ms
I0815 17:30:14.346812 5263 replica.cpp:322] Persisted replica status to VOTING
I0815 17:30:14.358101 5244 leveldb.cpp:174] Opened db in 10.053905ms
I0815 17:30:14.360924 5244 leveldb.cpp:181] Compacted db in 2.739416ms
I0815 17:30:14.361038 5244 leveldb.cpp:196] Created db iterator in 32672ns
I0815 17:30:14.361065 5244 leveldb.cpp:202] Seeked to beginning of db in 3239ns
I0815 17:30:14.361088 5244 leveldb.cpp:271] Iterated through 0 keys in the db in 562ns
I0815 17:30:14.361147 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:14.364094 5264 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.404351ms
I0815 17:30:14.364248 5264 replica.cpp:322] Persisted replica status to VOTING
I0815 17:30:14.374732 5244 leveldb.cpp:174] Opened db in 9.493182ms
I0815 17:30:14.381919 5244 leveldb.cpp:181] Compacted db in 7.105954ms
I0815 17:30:14.382040 5244 leveldb.cpp:196] Created db iterator in 41354ns
I0815 17:30:14.382102 5244 leveldb.cpp:202] Seeked to beginning of db in 38557ns
I0815 17:30:14.382170 5244 leveldb.cpp:271] Iterated through 1 keys in the db in 45244ns
I0815 17:30:14.382231 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:14.392118 5244 leveldb.cpp:174] Opened db in 9.530396ms
I0815 17:30:14.398756 5244 leveldb.cpp:181] Compacted db in 6.555416ms
I0815 17:30:14.398882 5244 leveldb.cpp:196] Created db iterator in 43289ns
I0815 17:30:14.398947 5244 leveldb.cpp:202] Seeked to beginning of db in 38366ns
I0815 17:30:14.399018 5244 leveldb.cpp:271] Iterated through 1 keys in the db in 47029ns
I0815 17:30:14.399081 5244 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I0815 17:30:14.400094 5269 recover.cpp:451] Starting replica recovery
I0815 17:30:14.400506 5269 recover.cpp:477] Replica is in VOTING status
I0815 17:30:14.400889 5269 recover.cpp:466] Recover process terminated
I0815 17:30:14.401396 5263 log.cpp:536] Attempting to start the writer
I0815 17:30:14.403096 5264 replica.cpp:496] Replica received implicit promise request from __req_res__(1642)@172.17.0.2:46055 with proposal 1
I0815 17:30:14.403158 5263 replica.cpp:496] Replica received implicit promise request from __req_res__(1643)@172.17.0.2:46055 with proposal 1
I0815 17:30:14.405604 5263 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.115303ms
I0815 17:30:14.405671 5263 replica.cpp:344] Persisted promised to 1
I0815 17:30:14.405623 5264 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 2.36439ms
I0815 17:30:14.405803 5264 replica.cpp:344] Persisted promised to 1
I0815 17:30:14.406754 5264 coordinator.cpp:238] Coordinator attempting to fill missing positions
*** Aborted at 1502818214 (unix time) try "date -d @1502818214" if you are using GNU date ***
I0815 17:30:14.408690 5266 replica.cpp:391] Replica received explicit promise request from __req_res__(1644)@172.17.0.2:46055 for position 0 with proposal 2
I0815 17:30:14.409052 5270 replica.cpp:391] Replica received explicit promise request from __req_res__(1645)@172.17.0.2:46055 for position 0 with proposal 2
I0815 17:30:14.410910 5270 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 1.706372ms
I0815 17:30:14.410917 5266 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 2.023712ms
I0815 17:30:14.411100 5266 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.410974 5270 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.413017 5268 replica.cpp:540] Replica received write request for position 0 from __req_res__(1646)@172.17.0.2:46055
I0815 17:30:14.413018 5266 replica.cpp:540] Replica received write request for position 0 from __req_res__(1647)@172.17.0.2:46055
I0815 17:30:14.413143 5268 leveldb.cpp:436] Reading position from leveldb took 51078ns
I0815 17:30:14.413378 5266 leveldb.cpp:436] Reading position from leveldb took 181918ns
PC: @ 0x2acdf7d3867a process::EventQueue::Consumer::empty()
I0815 17:30:14.426941 5266 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 13.398679ms
I0815 17:30:14.426950 5268 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 13.622152ms
I0815 17:30:14.427063 5266 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.427224 5268 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.428189 5266 replica.cpp:694] Replica received learned notice for position 0 from log-network(91)@172.17.0.2:46055
I0815 17:30:14.428457 5270 replica.cpp:694] Replica received learned notice for position 0 from log-network(91)@172.17.0.2:46055
*** SIGSEGV (@0x8) received by PID 5244 (TID 0x2ace02d45700) from PID 8; stack trace: ***
I0815 17:30:14.435797 5266 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 7.495887ms
I0815 17:30:14.435897 5266 replica.cpp:711] Persisted action NOP at position 0
@ 0x2ace2a197417 (unknown)
I0815 17:30:14.435845 5270 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 7.30663ms
I0815 17:30:14.436484 5270 replica.cpp:711] Persisted action NOP at position 0
I0815 17:30:14.437495 5268 log.cpp:552] Writer started with ending position 0
@ 0x2ace2a19b6f9 (unknown)
@ 0x2acdfa3d9330 (unknown)
I0815 17:30:14.439194 5263 leveldb.cpp:436] Reading position from leveldb took 86097ns
I0815 17:30:14.441635 5268 log.cpp:560] Attempting to append 49 bytes to the log
I0815 17:30:14.441921 5269 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0815 17:30:14.442967 5263 replica.cpp:540] Replica received write request for position 1 from __req_res__(1649)@172.17.0.2:46055
I0815 17:30:14.442984 5266 replica.cpp:540] Replica received write request for position 1 from __req_res__(1648)@172.17.0.2:46055
@ 0x2acdf7d3867a process::EventQueue::Consumer::empty()
@ 0x2acdf7d25328 process::ProcessManager::resume()
@ 0x2acdf7d21924 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x2acdf7d33092 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2acdf7d32fe9 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x2acdf7d32f82 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x2acdf9c5aa60 (unknown)
@ 0x2acdfa3d1184 start_thread
@ 0x2acdfa6e4ffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502810386-24508
Untagged: mesos-1502810386-24508:latest
Deleted: sha256:004c06b331c84bdc8e12dda144bfe49968f96ce72f28a89a83a0410c6e703f31
Deleted: sha256:5a964f902d16086c2ccb28dc511b6e71750e7e6421bb977a740cedebc9bc00a7
Deleted: sha256:161ba56a114b6f8787270f0cc5a4c6098c283fb0ff3dc361c01b6df9f5f78f12
Deleted: sha256:745ccaa8925f66b8432ada5d2b9064de78e5ecaf8c69a186b434819b661cfa79
Deleted: sha256:afba30f5e781d4ad29aa8c606c3f4d1a80df521e4ae247fa987595c940611a0d
Deleted: sha256:f3f4573b93819d38c52a2abfb026a82c331c91980c4b6d7c44df17287723c7f5
Deleted: sha256:b1189b8e784fe3e1ccb9858c81790d0148828182664b67f27f2f1e9ec188ad47
Deleted: sha256:617d5ff6b476189ca2a2943c0a23ee668267d055d2cdd849d0d93ad9d9ec2003
Deleted: sha256:0f9e25f1174d4cb1ef7c2227f6fa9d846d36082f115d823cda703f9cc3f3fc75
Deleted: sha256:3d30b765dc8d752ce21f09811a032d5d0cf5c1d721bf9c9193ed49bbd083ed33
Deleted: sha256:5353160c74a41f1277b6e8072e90b8d108543affaa7ca42ab686dc60b9a9d71a
Deleted: sha256:de1bb0d99b734ca2dc1e49686887e28b883503ef8ddf732c88638743262d63ba
Deleted: sha256:664dc2f51c0f7d04c34bd3e9eace8cea68e44cf4fe702c904183e28f8327f4c4
Deleted: sha256:2933214cd6d873847815d48123efbd7e9b5a5b1db40ed0534b25bad1acdd42b9
Deleted: sha256:048861ff44dfdcee5a9c6672f499a7ba95d19d389051887d2ac1f0ee45556ad3
Deleted: sha256:f1bfaa8d4d4e60d7ef3bdf21cd630ab88107ac0221af333a09162288c3dfef03
Deleted: sha256:e5c0319878c4051674556e346a28cbbd2705a664658d0f15f102ae0349774146
Deleted: sha256:3cf652c069eba15b9209c61d95c49ebe837ed3c41b2c6be058363faab2f14719
Deleted: sha256:1c57c62c819acefe314b8a409b6a5d6fa7cd9839df58136e23e83a0643ecf3f4
Deleted: sha256:052387f48b7cfa371d18e4cd6f8fd7e94585ebdb7f7f2546c34e99bc7a654bdd
Deleted: sha256:d28586678b7606e95f2ba803d90eec290febee77a365167802e811aeef062dfa
Deleted: sha256:c8119923223b13022586d6ca59c7a83b12858c5e76f95ae50801c84e2b5a1d9a
Deleted: sha256:ebd4ef53d12e35bc38d803a332ee673d700323654c99c42e886bfe52dabdf878
Deleted: sha256:96335333d58443aaf898964ec7dadcd3bf78de9c165dec786fcdc0c00fc1daff
Build step 'Execute shell' marked build as failure
Build failed in Jenkins: Mesos-Reviewbot #18878
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18878/display/redirect>
------------------------------------------
[...truncated 8.09 MB...]
I0815 15:13:33.205622 5278 hierarchical.cpp:626] Removed agent 4317b1bb-0109-4830-b83c-59044bd8c82c-S0
[ OK ] GarbageCollectorIntegrationTest.ExitedExecutor (194 ms)
[ RUN ] GarbageCollectorIntegrationTest.DiskUsage
I0815 15:13:33.212262 5253 cluster.cpp:162] Creating default 'local' authorizer
I0815 15:13:33.217293 5277 master.cpp:442] Master 7d93de72-68b6-442c-a3c6-cfd986790f42 (f9b3044a9377) started on 172.17.0.2:38361
I0815 15:13:33.217337 5277 master.cpp:444] 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/7HbKvB/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="/mesos/mesos-1.4.0/_inst/share/mesos/webui" --work_dir="/tmp/7HbKvB/master" --zk_session_timeout="10secs"
I0815 15:13:33.218312 5277 master.cpp:494] Master only allowing authenticated frameworks to register
I0815 15:13:33.218343 5277 master.cpp:508] Master only allowing authenticated agents to register
I0815 15:13:33.218384 5277 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0815 15:13:33.218663 5277 credentials.hpp:37] Loading credentials for authentication from '/tmp/7HbKvB/credentials'
I0815 15:13:33.219292 5277 master.cpp:566] Using default 'crammd5' authenticator
I0815 15:13:33.219730 5277 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0815 15:13:33.220124 5277 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0815 15:13:33.220683 5277 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0815 15:13:33.221071 5277 master.cpp:646] Authorization enabled
I0815 15:13:33.221575 5274 hierarchical.cpp:171] Initialized hierarchical allocator process
I0815 15:13:33.221606 5279 whitelist_watcher.cpp:77] No whitelist given
I0815 15:13:33.225466 5277 master.cpp:2163] Elected as the leading master!
I0815 15:13:33.225522 5277 master.cpp:1702] Recovering from registrar
I0815 15:13:33.225967 5273 registrar.cpp:347] Recovering registrar
I0815 15:13:33.226953 5273 registrar.cpp:391] Successfully fetched the registry (0B) in 928us
I0815 15:13:33.227318 5273 registrar.cpp:495] Applied 1 operations in 40482ns; attempting to update the registry
I0815 15:13:33.228595 5273 registrar.cpp:552] Successfully updated the registry in 1.195264ms
I0815 15:13:33.229029 5273 registrar.cpp:424] Successfully recovered registrar
I0815 15:13:33.229781 5273 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0815 15:13:33.229825 5279 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
I0815 15:13:33.238492 5253 process.cpp:3228] Attempting to spawn already spawned process files@172.17.0.2:38361
I0815 15:13:33.239284 5253 cluster.cpp:448] Creating default 'local' authorizer
I0815 15:13:33.242558 5279 slave.cpp:250] Mesos agent started on (87)@172.17.0.2:38361
I0815 15:13:33.242599 5279 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/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/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/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/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/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/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc" --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/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU"
I0815 15:13:33.243350 5279 credentials.hpp:86] Loading credential for authentication from '/tmp/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/credential'
I0815 15:13:33.243599 5279 slave.cpp:283] Agent using credential for: test-principal
I0815 15:13:33.243624 5279 credentials.hpp:37] Loading credentials for authentication from '/tmp/GarbageCollectorIntegrationTest_DiskUsage_DxoaYc/http_credentials'
I0815 15:13:33.244019 5279 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 15:13:33.244302 5279 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 15:13:33.246489 5279 slave.cpp:565] 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"}]
I0815 15:13:33.246918 5279 slave.cpp:573] Agent attributes: [ ]
I0815 15:13:33.246939 5279 slave.cpp:582] Agent hostname: f9b3044a9377
I0815 15:13:33.247254 5277 status_update_manager.cpp:177] Pausing sending status updates
I0815 15:13:33.249151 5274 state.cpp:64] Recovering state from '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/meta'
I0815 15:13:33.249660 5275 status_update_manager.cpp:203] Recovering status update manager
I0815 15:13:33.250355 5279 slave.cpp:6210] Finished recovery
I0815 15:13:33.250960 5279 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 15:13:33.251425 5274 slave.cpp:971] New master detected at master@172.17.0.2:38361
I0815 15:13:33.251462 5275 status_update_manager.cpp:177] Pausing sending status updates
I0815 15:13:33.251704 5274 slave.cpp:1006] Detecting new master
I0815 15:13:33.252012 5274 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 15:13:33.256296 5273 slave.cpp:1033] Authenticating with master master@172.17.0.2:38361
I0815 15:13:33.256649 5273 slave.cpp:1044] Using default CRAM-MD5 authenticatee
I0815 15:13:33.257149 5279 authenticatee.cpp:121] Creating new client SASL connection
I0815 15:13:33.257596 5279 master.cpp:7837] Authenticating slave(87)@172.17.0.2:38361
I0815 15:13:33.257761 5274 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(194)@172.17.0.2:38361
I0815 15:13:33.258324 5275 authenticator.cpp:98] Creating new server SASL connection
I0815 15:13:33.258993 5275 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0815 15:13:33.259210 5275 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0815 15:13:33.259534 5275 authenticator.cpp:204] Received SASL authentication start
I0815 15:13:33.259732 5275 authenticator.cpp:326] Authentication requires more steps
I0815 15:13:33.260023 5275 authenticatee.cpp:259] Received SASL authentication step
I0815 15:13:33.260326 5275 authenticator.cpp:232] Received SASL authentication step
I0815 15:13:33.260494 5275 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9b3044a9377' server FQDN: 'f9b3044a9377' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0815 15:13:33.260548 5275 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0815 15:13:33.260887 5275 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0815 15:13:33.261060 5275 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9b3044a9377' server FQDN: 'f9b3044a9377' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0815 15:13:33.261111 5275 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0815 15:13:33.261132 5275 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0815 15:13:33.261334 5275 authenticator.cpp:318] Authentication success
I0815 15:13:33.261649 5279 authenticatee.cpp:299] Authentication success
I0815 15:13:33.261760 5274 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(87)@172.17.0.2:38361
I0815 15:13:33.261796 5279 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(194)@172.17.0.2:38361
I0815 15:13:33.262316 5276 slave.cpp:1128] Successfully authenticated with master master@172.17.0.2:38361
I0815 15:13:33.262828 5276 slave.cpp:1572] Will retry registration in 6.027974ms if necessary
I0815 15:13:33.263121 5279 master.cpp:5712] Received register agent message from slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.263309 5279 master.cpp:3803] Authorizing agent with principal 'test-principal'
*** Aborted at 1502810013 (unix time) try "date -d @1502810013" if you are using GNU date ***
I0815 15:13:33.263967 5274 master.cpp:5772] Authorized registration of agent at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.264161 5274 master.cpp:5865] Registering agent at slave(87)@172.17.0.2:38361 (f9b3044a9377) with id 7d93de72-68b6-442c-a3c6-cfd986790f42-S0
I0815 15:13:33.264932 5274 registrar.cpp:495] Applied 1 operations in 74437ns; attempting to update the registry
I0815 15:13:33.265940 5278 registrar.cpp:552] Successfully updated the registry in 905984ns
I0815 15:13:33.266326 5278 master.cpp:5912] Admitted agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.267232 5274 slave.cpp:4887] Received ping from slave-observer(82)@172.17.0.2:38361
I0815 15:13:33.267232 5278 master.cpp:5943] Registered agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377) 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"}]
I0815 15:13:33.267719 5274 slave.cpp:1174] Registered with master master@172.17.0.2:38361; given agent ID 7d93de72-68b6-442c-a3c6-cfd986790f42-S0
I0815 15:13:33.268254 5274 slave.cpp:1194] Checkpointing SlaveInfo to '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/meta/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/slave.info'
I0815 15:13:33.268779 5272 hierarchical.cpp:593] Added agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 (f9b3044a9377) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0815 15:13:33.268824 5274 slave.cpp:1232] Forwarding total oversubscribed resources {}
I0815 15:13:33.269568 5272 hierarchical.cpp:1943] No allocations performed
I0815 15:13:33.269651 5272 hierarchical.cpp:1486] Performed allocation for 1 agents in 272667ns
I0815 15:13:33.269682 5279 status_update_manager.cpp:184] Resuming sending status updates
I0815 15:13:33.269825 5274 master.cpp:6688] Received update of agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377) with total oversubscribed resources {}
I0815 15:13:33.270279 5278 hierarchical.cpp:660] Agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 (f9b3044a9377) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0815 15:13:33.270316 5253 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.2:38361
I0815 15:13:33.273058 5253 sched.cpp:232] Version: 1.4.0
I0815 15:13:33.274070 5277 sched.cpp:336] New master detected at master@172.17.0.2:38361
I0815 15:13:33.274499 5277 sched.cpp:407] Authenticating with master master@172.17.0.2:38361
I0815 15:13:33.274529 5277 sched.cpp:414] Using default CRAM-MD5 authenticatee
I0815 15:13:33.275081 5279 authenticatee.cpp:121] Creating new client SASL connection
I0815 15:13:33.275677 5276 master.cpp:7837] Authenticating scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361
I0815 15:13:33.276192 5276 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(195)@172.17.0.2:38361
I0815 15:13:33.276923 5276 authenticator.cpp:98] Creating new server SASL connection
I0815 15:13:33.277484 5274 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0815 15:13:33.277525 5274 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0815 15:13:33.277647 5274 authenticator.cpp:204] Received SASL authentication start
I0815 15:13:33.277704 5274 authenticator.cpp:326] Authentication requires more steps
I0815 15:13:33.277884 5274 authenticatee.cpp:259] Received SASL authentication step
I0815 15:13:33.278103 5274 authenticator.cpp:232] Received SASL authentication step
I0815 15:13:33.278139 5274 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9b3044a9377' server FQDN: 'f9b3044a9377' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0815 15:13:33.278162 5274 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0815 15:13:33.278215 5274 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0815 15:13:33.278249 5274 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'f9b3044a9377' server FQDN: 'f9b3044a9377' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0815 15:13:33.278268 5274 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0815 15:13:33.278285 5274 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0815 15:13:33.278374 5274 authenticator.cpp:318] Authentication success
I0815 15:13:33.278724 5272 authenticatee.cpp:299] Authentication success
I0815 15:13:33.278744 5274 master.cpp:7867] Successfully authenticated principal 'test-principal' at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361
I0815 15:13:33.278882 5274 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(195)@172.17.0.2:38361
I0815 15:13:33.279412 5278 sched.cpp:513] Successfully authenticated with master master@172.17.0.2:38361
I0815 15:13:33.279449 5278 sched.cpp:836] Sending SUBSCRIBE call to master@172.17.0.2:38361
I0815 15:13:33.279623 5278 sched.cpp:869] Will retry registration in 1.794272343secs if necessary
I0815 15:13:33.280076 5276 master.cpp:2894] Received SUBSCRIBE call for framework 'default' at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361
I0815 15:13:33.280387 5276 master.cpp:2228] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0815 15:13:33.281208 5276 master.cpp:2974] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0815 15:13:33.282280 5276 sched.cpp:759] Framework registered with 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.282415 5274 hierarchical.cpp:303] Added framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.283082 5276 sched.cpp:773] Scheduler::registered took 749148ns
I0815 15:13:33.284623 5274 hierarchical.cpp:2033] No inverse offers to send out!
I0815 15:13:33.284729 5274 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.985955ms
I0815 15:13:33.285404 5278 master.cpp:7667] Sending 1 offers to framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (default) at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361
I0815 15:13:33.287235 5278 sched.cpp:933] Scheduler::resourceOffers took 1.219865ms
I0815 15:13:33.289170 5272 master.cpp:9164] Removing offer 7d93de72-68b6-442c-a3c6-cfd986790f42-O0
I0815 15:13:33.289649 5272 master.cpp:4153] Processing ACCEPT call for offers: [ 7d93de72-68b6-442c-a3c6-cfd986790f42-O0 ] on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377) for framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (default) at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361
I0815 15:13:33.289975 5272 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 0
W0815 15:13:33.293345 5274 validation.cpp:1294] Executor 'default' for task '0' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0815 15:13:33.293411 5274 validation.cpp:1306] Executor 'default' for task '0' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0815 15:13:33.294106 5274 master.cpp:9724] Adding task 0 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}] on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.294822 5274 master.cpp:4816] Launching task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (default) at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}] on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.295645 5278 slave.cpp:1701] Got assigned task '0' for framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
PC: @ 0x2b06cab7467a process::EventQueue::Consumer::empty()
I0815 15:13:33.296552 5278 slave.cpp:1982] Authorizing task '0' for framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.296649 5278 slave.cpp:6709] Authorizing framework principal 'test-principal' to launch task 0
I0815 15:13:33.297947 5278 slave.cpp:2169] Launching task '0' for framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
*** SIGSEGV (@0x8) received by PID 5253 (TID 0x2b06d5d82700) from PID 8; stack trace: ***
@ 0x2b06cd215330 (unknown)
I0815 15:13:33.298851 5278 paths.cpp:578] Trying to chown '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000/executors/default/runs/f7e8feb5-0b4e-4507-b349-14b200d48902' to user 'mesos'
I0815 15:13:33.299140 5278 slave.cpp:7165] Launching executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 with resources [] in work directory '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000/executors/default/runs/f7e8feb5-0b4e-4507-b349-14b200d48902'
I0815 15:13:33.299123 5274 hierarchical.cpp:887] Updated allocation of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 from cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000]
I0815 15:13:33.299777 5278 slave.cpp:2856] Launching container f7e8feb5-0b4e-4507-b349-14b200d48902 for executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.300247 5278 slave.cpp:2398] Queued task '0' for executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.300395 5278 slave.cpp:924] Successfully attached file '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000/executors/default/runs/f7e8feb5-0b4e-4507-b349-14b200d48902'
I0815 15:13:33.300933 5277 slave.cpp:924] Successfully attached file '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000/executors/default/runs/f7e8feb5-0b4e-4507-b349-14b200d48902'
I0815 15:13:33.301026 5274 hierarchical.cpp:1161] Recovered ports(allocated: *):[31000-32000]; disk(allocated: *):1024 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):2; mem(allocated: *):1024) on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 from framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.301131 5274 hierarchical.cpp:1207] Framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 filtered agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 for 5secs
I0815 15:13:33.304672 5276 process.cpp:3228] Attempting to spawn already spawned process version@172.17.0.2:38361
I0815 15:13:33.305151 5276 exec.cpp:162] Version: 1.4.0
I0815 15:13:33.305649 5279 exec.cpp:212] Executor started at: executor(15)@172.17.0.2:38361 with pid 5253
I0815 15:13:33.306159 5277 slave.cpp:3881] Got registration for executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 from executor(15)@172.17.0.2:38361
I0815 15:13:33.307360 5277 exec.cpp:237] Executor registered on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0
I0815 15:13:33.307443 5277 exec.cpp:249] Executor::registered took 29915ns
I0815 15:13:33.308428 5276 slave.cpp:2603] Sending queued task '0' to executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 at executor(15)@172.17.0.2:38361
I0815 15:13:33.309182 5276 exec.cpp:331] Executor asked to run task '0'
I0815 15:13:33.309497 5276 exec.cpp:340] Executor::launchTask took 267635ns
I0815 15:13:33.309798 5276 exec.cpp:571] Executor sending status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.310406 5276 slave.cpp:4345] Handling status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 from executor(15)@172.17.0.2:38361
I0815 15:13:33.311542 5274 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.311619 5274 status_update_manager.cpp:500] Creating StatusUpdate stream for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.312356 5274 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 to the agent
I0815 15:13:33.312767 5272 slave.cpp:4797] Forwarding the update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 to master@172.17.0.2:38361
I0815 15:13:33.313200 5272 slave.cpp:4691] Status update manager successfully handled status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.313282 5272 slave.cpp:4707] Sending acknowledgement for status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 to executor(15)@172.17.0.2:38361
I0815 15:13:33.314100 5272 master.cpp:6846] Status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 from agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.314203 5272 master.cpp:6908] Forwarding status update TASK_RUNNING (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.314781 5272 master.cpp:8933] Updating the state of task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0815 15:13:33.315140 5272 exec.cpp:388] Executor received status update acknowledgement 273bbbc9-888a-433c-b629-dd4191117e72 for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.315820 5272 sched.cpp:1041] Scheduler::statusUpdate took 146610ns
I0815 15:13:33.316646 5277 master.cpp:5477] Processing ACKNOWLEDGE call 273bbbc9-888a-433c-b629-dd4191117e72 for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (default) at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361 on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0
I0815 15:13:33.317476 5274 slave.cpp:4929] Got exited event for executor(15)@172.17.0.2:38361
I0815 15:13:33.317849 5272 slave.cpp:5329] Executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 exited with status 0
I0815 15:13:33.318195 5272 slave.cpp:4345] Handling status update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 from @0.0.0.0:0
I0815 15:13:33.318457 5279 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.319386 5272 slave.cpp:3609] Status update manager successfully handled status update acknowledgement (UUID: 273bbbc9-888a-433c-b629-dd4191117e72) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.319638 5273 master.cpp:6969] Executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377): exited with status 0
I0815 15:13:33.319772 5273 master.cpp:9056] Removing executor 'default' with resources [] of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.320505 5273 sched.cpp:1143] Executor default on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 exited with status 0
I0815 15:13:33.320574 5273 sched.cpp:1154] Scheduler::executorLost took 31158ns
I0815 15:13:33.321072 5274 status_update_manager.cpp:323] Received status update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.321449 5274 status_update_manager.cpp:377] Forwarding update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 to the agent
I0815 15:13:33.321905 5277 slave.cpp:4797] Forwarding the update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 to master@172.17.0.2:38361
I0815 15:13:33.322330 5277 slave.cpp:4691] Status update manager successfully handled status update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.322854 5273 master.cpp:6846] Status update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 from agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.322942 5273 master.cpp:6908] Forwarding status update TASK_FAILED (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.323331 5273 master.cpp:8933] Updating the state of task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (latest state: TASK_FAILED, status update state: TASK_FAILED)
I0815 15:13:33.323774 5279 sched.cpp:1041] Scheduler::statusUpdate took 28562ns
I0815 15:13:33.324483 5273 master.cpp:5477] Processing ACKNOWLEDGE call 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 (default) at scheduler-bd16cb3f-54f8-4ef5-9791-d26eef018463@172.17.0.2:38361 on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0
I0815 15:13:33.324596 5273 master.cpp:9027] Removing task 0 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}] of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 at slave(87)@172.17.0.2:38361 (f9b3044a9377)
I0815 15:13:33.325345 5279 hierarchical.cpp:1161] Recovered cpus(allocated: *):2; mem(allocated: *):1024 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 7d93de72-68b6-442c-a3c6-cfd986790f42-S0 from framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.325886 5274 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.326216 5274 status_update_manager.cpp:531] Cleaning up status update stream for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.326865 5277 slave.cpp:3609] Status update manager successfully handled status update acknowledgement (UUID: 9eaea6d9-ddcf-4531-9ceb-61e8ccff5a3c) for task 0 of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.326956 5277 slave.cpp:7561] Completing task 0
I0815 15:13:33.327055 5277 slave.cpp:5429] Cleaning up executor 'default' of framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000 at executor(15)@172.17.0.2:38361
I0815 15:13:33.327507 5276 gc.cpp:59] Scheduling '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000/executors/default/runs/f7e8feb5-0b4e-4507-b349-14b200d48902' for gc 6.99999633686518days in the future
I0815 15:13:33.327704 5277 slave.cpp:5525] Cleaning up framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.328034 5276 gc.cpp:59] Scheduling '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000/executors/default' for gc 6.99999633686518days in the future
I0815 15:13:33.328256 5277 status_update_manager.cpp:285] Closing status update streams for framework 7d93de72-68b6-442c-a3c6-cfd986790f42-0000
I0815 15:13:33.328310 5276 gc.cpp:59] Scheduling '/tmp/GarbageCollectorIntegrationTest_DiskUsage_aHxWeU/slaves/7d93de72-68b6-442c-a3c6-cfd986790f42-S0/frameworks/7d93de72-68b6-442c-a3c6-cfd986790f42-0000' for gc 6.99999633686518days in the future
@ 0x2b06cab7467a process::EventQueue::Consumer::empty()
@ 0x2b06cab61328 process::ProcessManager::resume()
@ 0x2b06cab5d924 _ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
@ 0x2b06cab6f092 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2b06cab6efe9 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
@ 0x2b06cab6ef82 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
@ 0x2b06cca96a60 (unknown)
@ 0x2b06cd20d184 start_thread
@ 0x2b06cd520ffd (unknown)
make[4]: *** [check-local] Segmentation fault (core dumped)
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502802925-11689
Untagged: mesos-1502802925-11689:latest
Deleted: sha256:eb2ae61319122a59358012da1bd6ad4be747c37aaef3519a4e4acc5e863a9a25
Deleted: sha256:d595da56be15f943d113b9c69da43ff81b088969eed06717242719a163a58b90
Deleted: sha256:ef12a32cb8dce95233b01388eb12669ec51159452dae21dc2d25a383fe023c05
Deleted: sha256:d19276630c2615e1e628354188a2efe2ee17a89004f0afb63cc3b64b3f80c318
Deleted: sha256:e9639838f0059482d08d964e2f8dc535d7f7cdb9b74d2009ba49065b03da904d
Deleted: sha256:cb24496bbd79ccba0f576a5a8a39881cbddc07fb92553598e11179d493e2089e
Deleted: sha256:06c11aa53a33e939e54e7957ccb76fdb115e500a43cde84390a59a63fb4702b1
Deleted: sha256:b4b90a98feff70a76ebbcb0078825198500f83052d5a06fdbb975b566c1e4717
Deleted: sha256:ba3539613054b7730cc608f2bc1eafdb615ad1af06af0ca2660f60649ed49251
Deleted: sha256:0328072a72226dcb992fa6e1cd3d0441d9f8bb491e1e8417d42bde6676368082
Deleted: sha256:04ba7d483a81caa718a4bf32b23637d368c69baaac8fe77f4e1a016d6dfe28c9
Deleted: sha256:8f949f49a117e0a7c6742d66c23ee9d6b1ba4e6dbfd62febb8e15ab47c82c810
Deleted: sha256:f7cf43f4ea4ca76946ddd8fd30622eca1cb6138b05f9ecd47c0133a02cce3992
Deleted: sha256:cc3df9630b2b6228f82ffad5e32151aed2286079545041a1a380962efa3dd0b9
Deleted: sha256:f6fdefea4639f9552e5867899e1ade1a3afab9011fbca699dc9e4e9d36731e8b
Deleted: sha256:4fea21742fb916f185c6d99ebce76bf641ca82dceca280126e98e50f86007854
Deleted: sha256:8c43f9e433c3cc860dfc91df00e0720acc9040123fcaed55578fe4dc3ee796c9
Deleted: sha256:b0ac0b24d59748b68a89d073e898794464dd0006fd0bbcf7162a3a89110266eb
Deleted: sha256:3ec0298d917e8a4e433a53b4797d1b7d1f973b6e880760e939deb93bb99a8179
Deleted: sha256:dbe8f88934167cb421b3a1bad365ee145622e0ec611d77dd9891a08bd81fdeab
Deleted: sha256:52f96354f98b6220e95d07ff9087eb8fe6e3dc37bda0893f79056948767d2b2e
Deleted: sha256:61d29ef8d16d38994801217998608201a6cd537aa5182dbb854342c71081797d
Deleted: sha256:c01b21f5ec8ddb8274f8e63a6b90429e54c40a4ce583eeb4663a29176188220a
Deleted: sha256:3449af1b58ca85a33ed63f799380a51354ea8f296a11e5afc9ba3b28e345852b
Build step 'Execute shell' marked build as failure
Build failed in Jenkins: Mesos-Reviewbot #18877
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18877/display/redirect>
------------------------------------------
[...truncated 30.46 MB...]
I0815 13:03:46.141121 5616 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz" --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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RJe3X8"
I0815 13:03:46.141474 5616 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/credential'
I0815 13:03:46.141628 5616 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.141650 5616 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_e2cRAz/http_credentials'
I0815 13:03:46.141871 5616 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.142015 5616 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.143332 5616 slave.cpp:565] 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"}]
I0815 13:03:46.143556 5616 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.143568 5616 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.143718 5612 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.145009 5615 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_RJe3X8/meta'
I0815 13:03:46.145462 5613 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.145822 5611 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.147972 5600 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.148464 5600 slave.cpp:6210] Finished recovery
I0815 13:03:46.148913 5600 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.149152 5600 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.152612 5598 process.cpp:3933] Handling HTTP event for process 'slave(799)' with path: '/slave(799)/containers'
I0815 13:03:46.154606 5605 http.cpp:1166] HTTP GET for /slave(799)/containers from 172.17.0.6:57092
I0815 13:03:46.154705 5605 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 13:03:46.160153 5618 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (42 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0815 13:03:46.179044 5579 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 13:03:46.179965 5579 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0815 13:03:46.180179 5579 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 13:03:46.180223 5579 provisioner.cpp:255] Using default backend 'copy'
I0815 13:03:46.186094 5619 slave.cpp:250] Mesos agent started on (800)@172.17.0.6:37364
I0815 13:03:46.186131 5619 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_FlkqIR"
I0815 13:03:46.186605 5619 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/credential'
I0815 13:03:46.186779 5619 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.186800 5619 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_syDJri/http_credentials'
I0815 13:03:46.187060 5619 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.187233 5619 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.188582 5619 slave.cpp:565] 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"}]
I0815 13:03:46.188830 5619 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.188845 5619 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.189043 5604 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.190397 5599 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_FlkqIR/meta'
I0815 13:03:46.190811 5599 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.191189 5610 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.192903 5621 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.193408 5612 slave.cpp:6210] Finished recovery
I0815 13:03:46.193982 5612 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.194339 5612 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.197417 5609 process.cpp:3933] Handling HTTP event for process 'slave(800)' with path: '/slave(800)/monitor/statistics'
I0815 13:03:46.198683 5616 http.cpp:1166] HTTP GET for /slave(800)/monitor/statistics from 172.17.0.6:57094
I0815 13:03:46.198750 5616 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0815 13:03:46.201711 5579 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (38 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0815 13:03:46.216069 5579 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 13:03:46.216717 5579 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0815 13:03:46.216883 5579 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 13:03:46.216923 5579 provisioner.cpp:255] Using default backend 'copy'
I0815 13:03:46.221271 5610 slave.cpp:250] Mesos agent started on (801)@172.17.0.6:37364
I0815 13:03:46.221318 5610 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_jxTvRA"
I0815 13:03:46.221793 5610 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/credential'
I0815 13:03:46.221989 5610 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.222020 5610 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_1aVuG1/http_credentials'
I0815 13:03:46.222332 5610 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.222537 5610 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.224308 5610 slave.cpp:565] 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"}]
I0815 13:03:46.224627 5610 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.224645 5610 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.224877 5600 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.226635 5618 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_jxTvRA/meta'
I0815 13:03:46.227005 5613 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.227339 5614 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.229132 5609 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.229662 5610 slave.cpp:6210] Finished recovery
I0815 13:03:46.230269 5610 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.230578 5603 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.233363 5611 process.cpp:3933] Handling HTTP event for process 'slave(801)' with path: '/slave(801)/monitor/statistics.json'
I0815 13:03:46.234920 5620 http.cpp:1166] HTTP GET for /slave(801)/monitor/statistics.json from 172.17.0.6:57096
I0815 13:03:46.235007 5620 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0815 13:03:46.237185 5579 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (36 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0815 13:03:46.254122 5579 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 13:03:46.255004 5579 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0815 13:03:46.255195 5579 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 13:03:46.255249 5579 provisioner.cpp:255] Using default backend 'copy'
I0815 13:03:46.261301 5599 slave.cpp:250] Mesos agent started on (802)@172.17.0.6:37364
I0815 13:03:46.261329 5599 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_SJTEmk"
I0815 13:03:46.261674 5599 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/credential'
I0815 13:03:46.261811 5599 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.261832 5599 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_GDIchL/http_credentials'
I0815 13:03:46.262053 5599 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.262213 5599 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.263494 5599 slave.cpp:565] 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"}]
I0815 13:03:46.263720 5599 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.263731 5599 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.263875 5611 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.265470 5609 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_SJTEmk/meta'
I0815 13:03:46.265882 5613 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.266121 5619 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.268084 5605 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.268591 5600 slave.cpp:6210] Finished recovery
I0815 13:03:46.269177 5600 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.269482 5617 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.272331 5621 process.cpp:3933] Handling HTTP event for process 'slave(802)' with path: '/slave(802)/containers'
I0815 13:03:46.273968 5604 http.cpp:1166] HTTP GET for /slave(802)/containers from 172.17.0.6:57098
I0815 13:03:46.274041 5604 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 13:03:46.277060 5579 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (38 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0815 13:03:46.292064 5579 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 13:03:46.292992 5579 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0815 13:03:46.293154 5579 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 13:03:46.293196 5579 provisioner.cpp:255] Using default backend 'copy'
I0815 13:03:46.295904 5579 cluster.cpp:448] Creating default 'local' authorizer
I0815 13:03:46.298383 5612 slave.cpp:250] Mesos agent started on (803)@172.17.0.6:37364
I0815 13:03:46.298413 5612 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_fslHe4"
I0815 13:03:46.298804 5612 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/credential'
I0815 13:03:46.298964 5612 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.298997 5612 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_kJcVev/http_credentials'
I0815 13:03:46.299271 5612 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.299489 5612 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.301534 5612 slave.cpp:565] 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"}]
I0815 13:03:46.301887 5612 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.301905 5612 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.302187 5608 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.304064 5604 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_fslHe4/meta'
I0815 13:03:46.304476 5610 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.304805 5617 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.306861 5608 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.307546 5614 slave.cpp:6210] Finished recovery
I0815 13:03:46.308100 5614 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.308377 5618 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.311110 5606 process.cpp:3933] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/monitor/statistics'
I0815 13:03:46.312472 5599 http.cpp:1166] HTTP GET for /slave(803)/monitor/statistics from 172.17.0.6:57100
I0815 13:03:46.312549 5599 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0815 13:03:46.317354 5579 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (41 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0815 13:03:46.335052 5579 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 13:03:46.335804 5579 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0815 13:03:46.335973 5579 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 13:03:46.336022 5579 provisioner.cpp:255] Using default backend 'copy'
I0815 13:03:46.338703 5579 cluster.cpp:448] Creating default 'local' authorizer
I0815 13:03:46.341172 5621 slave.cpp:250] Mesos agent started on (804)@172.17.0.6:37364
I0815 13:03:46.341214 5621 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jy6IuO"
I0815 13:03:46.341677 5621 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/credential'
I0815 13:03:46.341902 5621 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.341930 5621 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_YXShBf/http_credentials'
I0815 13:03:46.342280 5621 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.342507 5621 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.344427 5621 slave.cpp:565] 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"}]
I0815 13:03:46.344911 5621 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.344933 5621 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.345188 5619 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.347534 5620 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jy6IuO/meta'
I0815 13:03:46.348062 5617 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.348479 5613 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.350396 5602 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.351066 5602 slave.cpp:6210] Finished recovery
I0815 13:03:46.351609 5602 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.351948 5616 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.355027 5614 process.cpp:3933] Handling HTTP event for process 'slave(804)' with path: '/slave(804)/monitor/statistics.json'
I0815 13:03:46.356505 5598 http.cpp:1166] HTTP GET for /slave(804)/monitor/statistics.json from 172.17.0.6:57102
I0815 13:03:46.356596 5598 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0815 13:03:46.361295 5607 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (42 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0815 13:03:46.377061 5579 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 13:03:46.377691 5579 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0815 13:03:46.377817 5579 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 13:03:46.377863 5579 provisioner.cpp:255] Using default backend 'copy'
I0815 13:03:46.380455 5579 cluster.cpp:448] Creating default 'local' authorizer
I0815 13:03:46.383046 5603 slave.cpp:250] Mesos agent started on (805)@172.17.0.6:37364
I0815 13:03:46.383080 5603 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_UKN69y"
I0815 13:03:46.383635 5603 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/credential'
I0815 13:03:46.383838 5603 slave.cpp:283] Agent using credential for: test-principal
I0815 13:03:46.383867 5603 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Ub2Sm0/http_credentials'
I0815 13:03:46.384232 5603 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 13:03:46.384443 5603 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 13:03:46.386689 5603 slave.cpp:565] 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"}]
I0815 13:03:46.387099 5603 slave.cpp:573] Agent attributes: [ ]
I0815 13:03:46.387120 5603 slave.cpp:582] Agent hostname: f967de615f61
I0815 13:03:46.387313 5609 status_update_manager.cpp:177] Pausing sending status updates
I0815 13:03:46.388806 5601 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_UKN69y/meta'
I0815 13:03:46.389199 5601 status_update_manager.cpp:203] Recovering status update manager
I0815 13:03:46.389436 5601 containerizer.cpp:598] Recovering containerizer
I0815 13:03:46.391160 5616 provisioner.cpp:416] Provisioner recovery complete
I0815 13:03:46.391633 5598 slave.cpp:6210] Finished recovery
I0815 13:03:46.392032 5598 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 13:03:46.392297 5614 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 13:03:46.395077 5620 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/containers'
I0815 13:03:46.397053 5605 http.cpp:1166] HTTP GET for /slave(805)/containers from 172.17.0.6:57104
I0815 13:03:46.397130 5605 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 13:03:46.402107 5579 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (42 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (353 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (15 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (15 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (30 ms total)
[----------] Global test environment tear-down
[==========] 1655 tests from 182 test cases ran. (500195 ms total)
[ PASSED ] 1653 tests.
[ FAILED ] 2 tests, listed below:
[ FAILED ] ExamplesTest.PersistentVolumeFramework
[ FAILED ] ExamplesTest.DynamicReservationFramework
2 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
I0815 13:03:46.509783 5622 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502799101-31255
Untagged: mesos-1502799101-31255:latest
Deleted: sha256:68c55987f3a052383ce23aa6569ebcf308d8fa196f3c2f3cdb27570cbe18d5b5
Deleted: sha256:5672f7a3c903f43e7d7be4392ecb93c828af65ea95d6dafca00955ea85efb208
Deleted: sha256:d550e39fae18875c69a7bd220bbde16121c4b9761de6f5ac803f222494da0b5e
Deleted: sha256:d178181d2d04c9b75d244f51d093aa7c32f6aaddb2de30497beffce34a799a07
Deleted: sha256:e8387e063ea25b438546599934709b357732da8b42fd4ba2c8278183565ff664
Deleted: sha256:c8003eedb49e2e8646ff80b4c8536ce72fd7417773fa0aec0401611758111fa8
Deleted: sha256:9794f3f44eba87d493e202a2715c497f212273341c7afec1428dbe503c4fd0cd
Deleted: sha256:6920a0eacdca664745b44c55fd643db3be6fa7a001e07716f436531309b0d23c
Deleted: sha256:3938f1eef9261c4b6f6fec0d81e37fc551bbd2ed448d4a377cfb3c9bbe2f5016
Deleted: sha256:094e628f7ce47fea70e121bf492d129987d3ff81a2aae777a10d62f38240569e
Deleted: sha256:f3b221c3df346965aec6b4e57b433c2a96cc59c7f467c7bd5aab5fc443cce7d0
Deleted: sha256:7533b81ca92e36b28573ee28c37954f49d102a7844e38665cc6f04f931bd5402
Deleted: sha256:e142a86df787121bb33d50e86ffda9e122e148e5d6cee52fa5c44d8fa6c196c8
Deleted: sha256:9373c8100781de656c94c6d7dff915089efb119644755cf7e7fab47be2d7b08f
Deleted: sha256:b241fd4e26eb73b7260e9cbf0515e7706ffee99dec36c285661e6995f99f1f81
Deleted: sha256:0b0e60b79c63b3ddabc7daa8a436ccef9230319b6d05579ea4b33d78dca58112
Deleted: sha256:97a7a6cbad0387b1dd3314d98ca6863a3a08ff133f7b4f182f62c797e400fcdf
Deleted: sha256:6cd9b1cc7b3ca334d12fec8a06600fc5df15946bb5f369ca930ce8e69e00c593
Deleted: sha256:2a710826bc1d53956c362707e1cc0594a7dd4137b30364fb0d106bd2c26b3d39
Deleted: sha256:f6231a8d204944ccc880b477045ee8c39fd186fd24d92e3bf1cc37194c1afa8b
Deleted: sha256:18894366ace2a7df04f78041170c35d5654d758df8385ebc58f3685729fe6186
Deleted: sha256:a1e9969a7f6ac5acd1ffecc1da84cdfaeb4a0f82949727d9353584eba3db94c3
Deleted: sha256:c8ffd612b4c7005770f944bd3abc14d63c47ed0615a33139508ca27a4c1e1ecc
Deleted: sha256:380df8449b9c77d5bdc432650ca7e165a350a2120d9f5ad72d90dc67190c0b99
Build step 'Execute shell' marked build as failure
Build failed in Jenkins: Mesos-Reviewbot #18876
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot/18876/display/redirect>
------------------------------------------
[...truncated 31.01 MB...]
I0815 10:23:01.418109 5278 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.418138 5278 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_CcQ4qe/http_credentials'
I0815 10:23:01.418668 5278 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.419054 5278 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.421372 5278 slave.cpp:565] 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"}]
I0815 10:23:01.421798 5278 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.421820 5278 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.422201 5279 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.424377 5276 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_yR8GUC/meta'
I0815 10:23:01.439888 5278 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.440124 5278 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.442668 5278 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.443303 5275 slave.cpp:6210] Finished recovery
I0815 10:23:01.444279 5275 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.444679 5277 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.448842 5277 process.cpp:3933] Handling HTTP event for process 'slave(799)' with path: '/slave(799)/containers'
I0815 10:23:01.450920 5275 http.cpp:1166] HTTP GET for /slave(799)/containers from 172.17.0.2:60336
I0815 10:23:01.451187 5275 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 10:23:01.457103 5280 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (78 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0815 10:23:01.487252 5254 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 10:23:01.488149 5254 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 10:23:01.488353 5254 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 10:23:01.488472 5254 provisioner.cpp:255] Using default backend 'copy'
I0815 10:23:01.494688 5274 slave.cpp:250] Mesos agent started on (800)@172.17.0.2:40857
I0815 10:23:01.494729 5274 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_KXApv3"
I0815 10:23:01.495463 5274 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/credential'
I0815 10:23:01.495733 5274 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.495762 5274 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_krOreF/http_credentials'
I0815 10:23:01.496161 5274 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.496453 5274 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.498667 5274 slave.cpp:565] 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"}]
I0815 10:23:01.499097 5274 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.499120 5274 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.499382 5275 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.501346 5279 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_KXApv3/meta'
I0815 10:23:01.501845 5276 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.502245 5274 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.504622 5277 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.505517 5275 slave.cpp:6210] Finished recovery
I0815 10:23:01.506316 5275 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.506841 5273 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.510967 5277 process.cpp:3933] Handling HTTP event for process 'slave(800)' with path: '/slave(800)/monitor/statistics'
I0815 10:23:01.513166 5273 http.cpp:1166] HTTP GET for /slave(800)/monitor/statistics from 172.17.0.2:60338
I0815 10:23:01.513293 5273 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0815 10:23:01.517235 5254 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (47 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0815 10:23:01.535907 5254 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 10:23:01.536803 5254 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 10:23:01.537010 5254 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 10:23:01.537053 5254 provisioner.cpp:255] Using default backend 'copy'
I0815 10:23:01.543223 5274 slave.cpp:250] Mesos agent started on (801)@172.17.0.2:40857
I0815 10:23:01.543267 5274 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_62DoIu"
I0815 10:23:01.544023 5274 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/credential'
I0815 10:23:01.544286 5274 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.544314 5274 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qUlgz6/http_credentials'
I0815 10:23:01.544708 5274 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.544999 5274 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.547219 5274 slave.cpp:565] 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"}]
I0815 10:23:01.547646 5274 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.547667 5274 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.547984 5277 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.549906 5280 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_62DoIu/meta'
I0815 10:23:01.550457 5276 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.550765 5276 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.552960 5279 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.553684 5278 slave.cpp:6210] Finished recovery
I0815 10:23:01.554597 5278 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.555202 5276 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.559253 5275 process.cpp:3933] Handling HTTP event for process 'slave(801)' with path: '/slave(801)/monitor/statistics.json'
I0815 10:23:01.565438 5276 http.cpp:1166] HTTP GET for /slave(801)/monitor/statistics.json from 172.17.0.2:60340
I0815 10:23:01.565556 5276 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0815 10:23:01.578999 5254 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (61 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0815 10:23:01.596779 5254 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 10:23:01.597671 5254 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 10:23:01.597873 5254 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 10:23:01.597916 5254 provisioner.cpp:255] Using default backend 'copy'
I0815 10:23:01.604102 5273 slave.cpp:250] Mesos agent started on (802)@172.17.0.2:40857
I0815 10:23:01.604146 5273 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy" --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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UwIQuW"
I0815 10:23:01.604867 5273 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/credential'
I0815 10:23:01.605126 5273 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.605152 5273 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_gLTzvy/http_credentials'
I0815 10:23:01.605518 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.605778 5273 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.607920 5273 slave.cpp:565] 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"}]
I0815 10:23:01.608346 5273 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.608369 5273 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.608780 5275 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.610692 5279 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_UwIQuW/meta'
I0815 10:23:01.611263 5278 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.611641 5277 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.613886 5280 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.614624 5274 slave.cpp:6210] Finished recovery
I0815 10:23:01.615247 5274 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.615711 5276 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.619717 5280 process.cpp:3933] Handling HTTP event for process 'slave(802)' with path: '/slave(802)/containers'
I0815 10:23:01.621773 5279 http.cpp:1166] HTTP GET for /slave(802)/containers from 172.17.0.2:60342
I0815 10:23:01.622104 5279 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 10:23:01.625986 5279 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (48 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0815 10:23:01.646258 5254 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 10:23:01.647155 5254 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 10:23:01.647431 5254 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 10:23:01.647475 5254 provisioner.cpp:255] Using default backend 'copy'
I0815 10:23:01.650326 5254 cluster.cpp:448] Creating default 'local' authorizer
I0815 10:23:01.653947 5276 slave.cpp:250] Mesos agent started on (803)@172.17.0.2:40857
I0815 10:23:01.653991 5276 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_AmyNQo"
I0815 10:23:01.654846 5276 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/credential'
I0815 10:23:01.655318 5276 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.655349 5276 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_y0KrZ0/http_credentials'
I0815 10:23:01.655783 5276 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.656175 5276 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.658479 5276 slave.cpp:565] 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"}]
I0815 10:23:01.658902 5276 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.658923 5276 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.659193 5277 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.661310 5280 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_AmyNQo/meta'
I0815 10:23:01.661981 5280 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.662394 5274 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.664691 5278 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.665428 5277 slave.cpp:6210] Finished recovery
I0815 10:23:01.666213 5277 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.666678 5279 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.670944 5276 process.cpp:3933] Handling HTTP event for process 'slave(803)' with path: '/slave(803)/monitor/statistics'
I0815 10:23:01.673259 5279 http.cpp:1166] HTTP GET for /slave(803)/monitor/statistics from 172.17.0.2:60344
I0815 10:23:01.673501 5279 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0815 10:23:01.678926 5274 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (52 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0815 10:23:01.698531 5254 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 10:23:01.699430 5254 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 10:23:01.699635 5254 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 10:23:01.699756 5254 provisioner.cpp:255] Using default backend 'copy'
I0815 10:23:01.702600 5254 cluster.cpp:448] Creating default 'local' authorizer
I0815 10:23:01.706466 5280 slave.cpp:250] Mesos agent started on (804)@172.17.0.2:40857
I0815 10:23:01.706540 5280 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_EahRJR"
I0815 10:23:01.708487 5280 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/credential'
I0815 10:23:01.708832 5280 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.708884 5280 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_QnMY0t/http_credentials'
I0815 10:23:01.709357 5280 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.709715 5280 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.712021 5280 slave.cpp:565] 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"}]
I0815 10:23:01.712630 5280 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.712723 5280 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.713093 5273 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.715138 5276 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_EahRJR/meta'
I0815 10:23:01.715793 5273 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.716220 5278 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.718564 5278 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.719180 5275 slave.cpp:6210] Finished recovery
I0815 10:23:01.719996 5275 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.720592 5274 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.724818 5275 process.cpp:3933] Handling HTTP event for process 'slave(804)' with path: '/slave(804)/monitor/statistics.json'
I0815 10:23:01.727138 5279 http.cpp:1166] HTTP GET for /slave(804)/monitor/statistics.json from 172.17.0.2:60346
I0815 10:23:01.727381 5279 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0815 10:23:01.732689 5279 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (53 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0815 10:23:01.752408 5254 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0815 10:23:01.753307 5254 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0815 10:23:01.753509 5254 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0815 10:23:01.753634 5254 provisioner.cpp:255] Using default backend 'copy'
I0815 10:23:01.756501 5254 cluster.cpp:448] Creating default 'local' authorizer
I0815 10:23:01.759977 5280 slave.cpp:250] Mesos agent started on (805)@172.17.0.2:40857
I0815 10:23:01.760049 5280 slave.cpp:251] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX" --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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_SHCybl"
I0815 10:23:01.760848 5280 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/credential'
I0815 10:23:01.761189 5280 slave.cpp:283] Agent using credential for: test-principal
I0815 10:23:01.761243 5280 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_23wpBX/http_credentials'
I0815 10:23:01.761724 5280 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0815 10:23:01.762099 5280 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0815 10:23:01.764400 5280 slave.cpp:565] 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"}]
I0815 10:23:01.764878 5280 slave.cpp:573] Agent attributes: [ ]
I0815 10:23:01.764926 5280 slave.cpp:582] Agent hostname: 3e8535be347c
I0815 10:23:01.765338 5278 status_update_manager.cpp:177] Pausing sending status updates
I0815 10:23:01.767541 5273 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_SHCybl/meta'
I0815 10:23:01.768067 5277 status_update_manager.cpp:203] Recovering status update manager
I0815 10:23:01.768450 5279 containerizer.cpp:598] Recovering containerizer
I0815 10:23:01.770799 5276 provisioner.cpp:416] Provisioner recovery complete
I0815 10:23:01.771345 5273 slave.cpp:6210] Finished recovery
I0815 10:23:01.771972 5273 slave.cpp:6392] Querying resource estimator for oversubscribable resources
I0815 10:23:01.772517 5279 slave.cpp:6406] Received oversubscribable resources {} from the resource estimator
I0815 10:23:01.776588 5276 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/containers'
I0815 10:23:01.778734 5280 http.cpp:1166] HTTP GET for /slave(805)/containers from 172.17.0.2:60348
I0815 10:23:01.778894 5280 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0815 10:23:01.785148 5254 slave.cpp:843] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (52 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (497 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (19 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (20 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (39 ms total)
[----------] Global test environment tear-down
[==========] 1651 tests from 181 test cases ran. (775239 ms total)
[ PASSED ] 1647 tests.
[ FAILED ] 4 tests, listed below:
[ FAILED ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckStatusChange
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask
4 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
I0815 10:23:01.971077 5281 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1502786085-15339
Untagged: mesos-1502786085-15339:latest
Deleted: sha256:d09b2444a21dbafe463d0b84eb0a60c2cc5328962dd02001eaba35410103a9f8
Deleted: sha256:67d157901969f5877d6f34f39b77e8ef89ddcf3e57a65d0aac35be61fafa5873
Deleted: sha256:5d5129c2f557c805e38b8ac8a7d2946dfb1e3eac31ec0e5fd1af005fb7093237
Deleted: sha256:b62ac9b31a3efef6bff6b1c8ce50c0fbaf39978e7e42eeec51b0b7b0dfc00cf9
Deleted: sha256:0dde041c0745a05e3b2e9fc7b19efe8e3af3df8d4e1a4d90e42a6a97340d190f
Deleted: sha256:cf90a35500871003398256575b39333a3f0cd8700bf03f6f12b010a85f106c27
Deleted: sha256:d03b68a7841953899fe915dfec3c1223dfeca49da88f5e7f3c4f9c313c072d42
Deleted: sha256:9e9b8db81c7622f42cbd3a5678c83e0737d3224525a0660525e96b08f495d562
Deleted: sha256:d0440c8df806e105b6de90276d3061f2b3f61b120f9774b4dbc4c57469399287
Deleted: sha256:2e91e05d59434eb6c51bb34674f133feba041c5a9414635a7f98597f8d63bbe0
Deleted: sha256:f1c17064a5e038d1346cfa69f1dfe04b9476cdea6ebda2cae83f5770db964bc8
Deleted: sha256:919f8608d4cceb341d8d61d173d57e7f68fc50783b1ee1bc3ad7f717360fac00
Deleted: sha256:8e633efe7df315ed548a1d7eeccba9430a40de37354a66576c75f6a5c9a3ec5e
Deleted: sha256:dd19eb04d50a80d35e78da38c06a568ded1ec65611cd3210b48a5400fb36a02a
Deleted: sha256:7d0ecb7f0aa70aeee4d3fcc5c6c798bac1a41248f61b6517a8f0a5790e8993bc
Deleted: sha256:40bcac64ec31723d9aeac44da35ad339028398e72f803be6a46346646ce3546b
Deleted: sha256:9c7c1706f0fd48bc28a2e8c427d9dd33a7eca531af63189e13002893e86d3405
Deleted: sha256:1925b61ce65ed81ac1dcba496deacb48eb3195bf0249a97e1391fcfbfee678c5
Deleted: sha256:059ba18929e727a2774557646c6bbbbe29310ae78b4fcb5f3fdeebe597998c51
Deleted: sha256:32ee9cffbc5fce4124d38917c596c12a5994c032b6b6e85d09b79139185f8e44
Deleted: sha256:904a1ba611e6f0a3a747f1190380f6735ff6d4f6195c4fdd4e9f65e4e83745e7
Deleted: sha256:9e6cab52f39ec4011a04482f259a688d75b8ddc96c5deca192bdd3a41985bd05
Deleted: sha256:50536d848cadbc6e4d862ef7434e37b8a82061e9179206a0ad87f6aa17a36004
Deleted: sha256:182b81294f693d52a3b800243472280d09eb9df92c2399f200d68972a31969f1
Build step 'Execute shell' marked build as failure