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/22 05:16:50 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4136
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4136/display/redirect?page=changes>
Changes:
[xujyan] Fix spelling of "container".
[xujyan] Tracked successful task fetches rather than total.
[gregorywmann] Included nested command check output in the executor logs.
[gregorywmann] Made the log output handling of TCP and HTTP checks consistent.
[gregorywmann] Raised the logging level of some check and health check messages.
[gregorywmann] Fixed an incorrect line break in the checker process.
[josephwu] Windows: Fully qualified reference to recordio::Decoder.
[josephwu] Renamed CONTAINERS_DIR to EXECUTOR_RUNS_DIR.
[josephwu] Updated depiction of runtime directory file structure.
------------------------------------------
[...truncated 32.15 MB...]
I0822 05:16:29.282665 30254 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_nAX4bN/http_credentials'
I0822 05:16:29.282932 30254 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.283059 30254 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.283278 30254 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.283370 30254 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.283545 30254 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.283638 30254 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.284952 30254 slave.cpp:581] 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"}]
I0822 05:16:29.285177 30254 slave.cpp:589] Agent attributes: [ ]
I0822 05:16:29.285192 30254 slave.cpp:598] Agent hostname: 5f009ccd2282
I0822 05:16:29.285322 30257 status_update_manager.cpp:177] Pausing sending status updates
I0822 05:16:29.286979 30244 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_NCmBnA/meta'
I0822 05:16:29.287365 30265 status_update_manager.cpp:203] Recovering status update manager
I0822 05:16:29.287545 30250 containerizer.cpp:609] Recovering containerizer
I0822 05:16:29.289101 30256 provisioner.cpp:416] Provisioner recovery complete
I0822 05:16:29.289475 30249 slave.cpp:6226] Finished recovery
I0822 05:16:29.290010 30249 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 05:16:29.290292 30258 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 05:16:29.292897 30263 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/monitor/statistics'
I0822 05:16:29.294800 30244 http.cpp:1166] HTTP GET for /slave(805)/monitor/statistics from 172.17.0.8:47938
I0822 05:16:29.294911 30244 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0822 05:16:29.296739 30262 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (30 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0822 05:16:29.307387 9517 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 05:16:29.307966 9517 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 05:16:29.308073 9517 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 05:16:29.308104 9517 provisioner.cpp:255] Using default backend 'copy'
I0822 05:16:29.311259 30244 slave.cpp:252] Mesos agent started on (806)@172.17.0.8:45445
I0822 05:16:29.311301 30244 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_bLp3GC/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_bLp3GC/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_bLp3GC/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_bLp3GC/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_bLp3GC/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_bLp3GC/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_bLp3GC" --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_0TbbOp"
I0822 05:16:29.312000 30244 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_bLp3GC/credential'
I0822 05:16:29.312249 30244 slave.cpp:285] Agent using credential for: test-principal
I0822 05:16:29.312275 30244 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_bLp3GC/http_credentials'
I0822 05:16:29.312649 30244 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.312858 30244 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.313122 30244 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.313235 30244 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.313441 30244 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.313552 30244 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.315521 30244 slave.cpp:581] 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"}]
I0822 05:16:29.315853 30244 slave.cpp:589] Agent attributes: [ ]
I0822 05:16:29.315874 30244 slave.cpp:598] Agent hostname: 5f009ccd2282
I0822 05:16:29.316015 30249 status_update_manager.cpp:177] Pausing sending status updates
I0822 05:16:29.318208 30251 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_0TbbOp/meta'
I0822 05:16:29.318480 30250 status_update_manager.cpp:203] Recovering status update manager
I0822 05:16:29.318663 30259 containerizer.cpp:609] Recovering containerizer
I0822 05:16:29.319980 30248 provisioner.cpp:416] Provisioner recovery complete
I0822 05:16:29.320260 30258 slave.cpp:6226] Finished recovery
I0822 05:16:29.320708 30258 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 05:16:29.320931 30243 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 05:16:29.322876 30265 process.cpp:3933] Handling HTTP event for process 'slave(806)' with path: '/slave(806)/monitor/statistics.json'
I0822 05:16:29.324461 30250 http.cpp:1166] HTTP GET for /slave(806)/monitor/statistics.json from 172.17.0.8:47942
I0822 05:16:29.324527 30250 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0822 05:16:29.325870 30260 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (28 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0822 05:16:29.335167 9517 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 05:16:29.335582 9517 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 05:16:29.335672 9517 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 05:16:29.335700 9517 provisioner.cpp:255] Using default backend 'copy'
I0822 05:16:29.338724 30259 slave.cpp:252] Mesos agent started on (807)@172.17.0.8:45445
I0822 05:16:29.338763 30259 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Kebbts/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Kebbts/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_Kebbts/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Kebbts/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Kebbts/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_Kebbts/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_Kebbts" --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_36J7vf"
I0822 05:16:29.339265 30259 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Kebbts/credential'
I0822 05:16:29.339489 30259 slave.cpp:285] Agent using credential for: test-principal
I0822 05:16:29.339514 30259 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Kebbts/http_credentials'
I0822 05:16:29.339804 30259 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.339975 30259 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.340189 30259 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.340296 30259 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.340471 30259 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.340571 30259 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.341929 30259 slave.cpp:581] 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"}]
I0822 05:16:29.342159 30259 slave.cpp:589] Agent attributes: [ ]
I0822 05:16:29.342195 30259 slave.cpp:598] Agent hostname: 5f009ccd2282
I0822 05:16:29.342330 30247 status_update_manager.cpp:177] Pausing sending status updates
I0822 05:16:29.343901 30250 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_36J7vf/meta'
I0822 05:16:29.344138 30250 status_update_manager.cpp:203] Recovering status update manager
I0822 05:16:29.344283 30266 containerizer.cpp:609] Recovering containerizer
I0822 05:16:29.345505 30253 provisioner.cpp:416] Provisioner recovery complete
I0822 05:16:29.345818 30245 slave.cpp:6226] Finished recovery
I0822 05:16:29.346226 30245 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 05:16:29.346446 30246 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 05:16:29.348078 30247 process.cpp:3933] Handling HTTP event for process 'slave(807)' with path: '/slave(807)/containers'
I0822 05:16:29.349618 30254 http.cpp:1166] HTTP GET for /slave(807)/containers from 172.17.0.8:47944
I0822 05:16:29.349679 30254 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0822 05:16:29.351115 30265 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (25 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0822 05:16:29.360808 9517 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 05:16:29.361238 9517 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 05:16:29.361335 9517 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 05:16:29.361364 9517 provisioner.cpp:255] Using default backend 'copy'
I0822 05:16:29.362915 9517 cluster.cpp:448] Creating default 'local' authorizer
I0822 05:16:29.364547 30248 slave.cpp:252] Mesos agent started on (808)@172.17.0.8:45445
I0822 05:16:29.364565 30248 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_N03oui/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_N03oui/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_N03oui/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_N03oui/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_N03oui/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_N03oui/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_N03oui" --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_7WjAt5"
I0822 05:16:29.364936 30248 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_N03oui/credential'
I0822 05:16:29.365092 30248 slave.cpp:285] Agent using credential for: test-principal
I0822 05:16:29.365113 30248 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_N03oui/http_credentials'
I0822 05:16:29.365375 30248 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.365497 30248 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.365689 30248 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.365780 30248 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.365941 30248 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.366032 30248 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.367393 30248 slave.cpp:581] 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"}]
I0822 05:16:29.367615 30248 slave.cpp:589] Agent attributes: [ ]
I0822 05:16:29.367631 30248 slave.cpp:598] Agent hostname: 5f009ccd2282
I0822 05:16:29.367754 30247 status_update_manager.cpp:177] Pausing sending status updates
I0822 05:16:29.369309 30254 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_7WjAt5/meta'
I0822 05:16:29.369612 30265 status_update_manager.cpp:203] Recovering status update manager
I0822 05:16:29.369812 30243 containerizer.cpp:609] Recovering containerizer
I0822 05:16:29.371098 30249 provisioner.cpp:416] Provisioner recovery complete
I0822 05:16:29.371506 30259 slave.cpp:6226] Finished recovery
I0822 05:16:29.372037 30259 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 05:16:29.372267 30246 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 05:16:29.374418 30244 process.cpp:3933] Handling HTTP event for process 'slave(808)' with path: '/slave(808)/monitor/statistics'
I0822 05:16:29.376336 30245 http.cpp:1166] HTTP GET for /slave(808)/monitor/statistics from 172.17.0.8:47948
I0822 05:16:29.376421 30245 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0822 05:16:29.379681 30259 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (28 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0822 05:16:29.390625 9517 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 05:16:29.391374 9517 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 05:16:29.391513 9517 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 05:16:29.391558 9517 provisioner.cpp:255] Using default backend 'copy'
I0822 05:16:29.393935 9517 cluster.cpp:448] Creating default 'local' authorizer
I0822 05:16:29.396539 30261 slave.cpp:252] Mesos agent started on (809)@172.17.0.8:45445
I0822 05:16:29.396566 30261 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_J1kEM8/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_J1kEM8/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_J1kEM8/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_J1kEM8/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_J1kEM8/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_J1kEM8/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_J1kEM8" --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_8WOpHV"
I0822 05:16:29.397210 30261 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_J1kEM8/credential'
I0822 05:16:29.397428 30261 slave.cpp:285] Agent using credential for: test-principal
I0822 05:16:29.397455 30261 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_J1kEM8/http_credentials'
I0822 05:16:29.397860 30261 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.398015 30261 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.398327 30261 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.398450 30261 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.398682 30261 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.398802 30261 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.400969 30261 slave.cpp:581] 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"}]
I0822 05:16:29.401309 30261 slave.cpp:589] Agent attributes: [ ]
I0822 05:16:29.401334 30261 slave.cpp:598] Agent hostname: 5f009ccd2282
I0822 05:16:29.401484 30249 status_update_manager.cpp:177] Pausing sending status updates
I0822 05:16:29.403728 30245 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_8WOpHV/meta'
I0822 05:16:29.404026 30266 status_update_manager.cpp:203] Recovering status update manager
I0822 05:16:29.404201 30256 containerizer.cpp:609] Recovering containerizer
I0822 05:16:29.405580 30262 provisioner.cpp:416] Provisioner recovery complete
I0822 05:16:29.405987 30252 slave.cpp:6226] Finished recovery
I0822 05:16:29.406590 30252 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 05:16:29.406920 30243 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 05:16:29.409209 30253 process.cpp:3933] Handling HTTP event for process 'slave(809)' with path: '/slave(809)/monitor/statistics.json'
I0822 05:16:29.410841 30266 http.cpp:1166] HTTP GET for /slave(809)/monitor/statistics.json from 172.17.0.8:47952
I0822 05:16:29.410907 30266 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0822 05:16:29.413468 9517 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (33 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0822 05:16:29.424441 9517 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 05:16:29.424914 9517 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 05:16:29.425020 9517 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 05:16:29.425051 9517 provisioner.cpp:255] Using default backend 'copy'
I0822 05:16:29.426765 9517 cluster.cpp:448] Creating default 'local' authorizer
I0822 05:16:29.428406 30266 slave.cpp:252] Mesos agent started on (810)@172.17.0.8:45445
I0822 05:16:29.428426 30266 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_NVebpZ/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_NVebpZ/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_NVebpZ/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_NVebpZ/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_NVebpZ/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_NVebpZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_NVebpZ" --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_nKUTeM"
I0822 05:16:29.428830 30266 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_NVebpZ/credential'
I0822 05:16:29.429008 30266 slave.cpp:285] Agent using credential for: test-principal
I0822 05:16:29.429033 30266 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_NVebpZ/http_credentials'
I0822 05:16:29.429332 30266 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.429471 30266 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 05:16:29.429690 30266 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.429808 30266 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 05:16:29.430002 30266 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.430114 30266 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 05:16:29.431481 30266 slave.cpp:581] 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"}]
I0822 05:16:29.431697 30266 slave.cpp:589] Agent attributes: [ ]
I0822 05:16:29.431720 30266 slave.cpp:598] Agent hostname: 5f009ccd2282
I0822 05:16:29.431851 30258 status_update_manager.cpp:177] Pausing sending status updates
I0822 05:16:29.433372 30252 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_nKUTeM/meta'
I0822 05:16:29.433645 30259 status_update_manager.cpp:203] Recovering status update manager
I0822 05:16:29.433811 30243 containerizer.cpp:609] Recovering containerizer
I0822 05:16:29.435111 30260 provisioner.cpp:416] Provisioner recovery complete
I0822 05:16:29.435396 30249 slave.cpp:6226] Finished recovery
I0822 05:16:29.435860 30249 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 05:16:29.436103 30256 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 05:16:29.438094 30245 process.cpp:3933] Handling HTTP event for process 'slave(810)' with path: '/slave(810)/containers'
I0822 05:16:29.439597 30259 http.cpp:1166] HTTP GET for /slave(810)/containers from 172.17.0.8:47956
I0822 05:16:29.439659 30259 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0822 05:16:29.443109 9517 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (29 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (274 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (9 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (8 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (17 ms total)
[----------] Global test environment tear-down
[==========] 1664 tests from 184 test cases ran. (658571 ms total)
[ PASSED ] 1658 tests.
[ FAILED ] 6 tests, listed below:
[ FAILED ] CommandExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckStatusChange
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask
[ FAILED ] ExamplesTest.TestHTTPFramework
6 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
I0822 05:16:29.525450 30267 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1503375678-21652
Untagged: mesos-1503375678-21652:latest
Deleted: sha256:e7052829e44988b4fd16337a5267fd3ecf09ae0184bfd2c199e3e1e4a80d7292
Deleted: sha256:419d27a9605affadd11decde0ff3b13c81f51711618249d544ad28c487923278
Deleted: sha256:78281f06ee4b9c3640ca166bfa9bb3aca918d5edddf30792a83bf3ea957fd929
Deleted: sha256:06c8f62753790fd74fceed8b072214ab90bb81feee2ebd2d7cd3669c1351a187
Deleted: sha256:f5b3e5046ba761d7023da7b20486ea2850ff1e60aa6f44758593f937f81645ca
Deleted: sha256:eef82e41c3264d9717288105a3e31b0c741721d75543318adc7f820daf154576
Deleted: sha256:9fce10f1c1ecefa13e6d68c85c32d54b8614d8f03a8d79f2f7aa7ced887e64d9
Deleted: sha256:731506631e401ff29423e1193b1f6ea98bf85bf08dc654e6aea5ffc6c765a0ac
Deleted: sha256:2b9c871248ec780ef60ece07d97a84c1e51fae5cd0bb0657aba5c3d7577109b6
Deleted: sha256:a41d5cc752cec0204998203c3b93a57fd0beeb89e604749508eaee0105bdcc96
Deleted: sha256:2cbea841e86d44a42b29df09826fd2fb895162144a260a9b13426dd43d1a33b0
Deleted: sha256:85c146501b58a623586643f1369996f245fda2aa53828f846c1f9f26279c0b75
Deleted: sha256:e1ed9951f7ef891ffc8605f84c61d6c09efc4732275be58e3fb6a8cd42af3ac5
Deleted: sha256:65edc56705fa706eb7d5f982547766aa40658ae8a800b3f8528fc0f700105a65
Deleted: sha256:10a4ba3ff5bc6eccbee8ab68d8c849820e2638a82cc378c0d43d44482ab035cc
Deleted: sha256:3a0bffff228109154e256a1dfdfae2d13100f47615f4ee010508eafde5ba4da8
Deleted: sha256:58397b82955dea358f3a25fbd263b43ad742537c0e7c1e9f067b0aba8294abaa
Deleted: sha256:7125462123da3751689f1add7cd3b26cb5e61e08b0b6130b1d28cf216ec578a3
Deleted: sha256:a58c02321fb54eba53c5f15674f24854263defecf894396b271b4253439ecfd4
Deleted: sha256:6a3b2fbb2df94483a1804d6364dc0d8832d1b7298cb043edccfc8ef3c077ac15
Deleted: sha256:b53271ea1ee8127b1c1804e934b1b81ef16562b79f8cdd2705832cdd0fc1cbf8
Deleted: sha256:2f48dad0fc3bec8b5218d2f78fdb28fa9104a96a480b0e88a00d002809898bef
Deleted: sha256:aea6c6ab9d0015918899993bddd675029f2208232aeed6f106e0ef4ded7b22ce
Deleted: sha256:908b88540cf9ca5dbc6d73f447057a2adc73a36b8300eb08f99b255eece7ffee
Deleted: sha256:82d71425bdfbc55a8f6de4e2b2a9aa763474a8cfaa665b8aed62702f1cfbf3d9
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user xujyan@apple.com
Not sending mail to unregistered user gregorywmann@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4140
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4140/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4139
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4139/display/redirect>
------------------------------------------
[...truncated 32.24 MB...]
I0822 16:30:45.021371 30453 slave.cpp:285] Agent using credential for: test-principal
I0822 16:30:45.021399 30453 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_LVK5rz/http_credentials'
I0822 16:30:45.021756 30453 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.021877 30453 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.022071 30453 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.022169 30453 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.022346 30453 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.022435 30453 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.023718 30453 slave.cpp:581] 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"}]
I0822 16:30:45.023931 30453 slave.cpp:589] Agent attributes: [ ]
I0822 16:30:45.023944 30453 slave.cpp:598] Agent hostname: 498bb002959f
I0822 16:30:45.024083 30448 status_update_manager.cpp:177] Pausing sending status updates
I0822 16:30:45.025444 30455 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_9RyEdI/meta'
I0822 16:30:45.025696 30441 status_update_manager.cpp:203] Recovering status update manager
I0822 16:30:45.025874 30434 containerizer.cpp:609] Recovering containerizer
I0822 16:30:45.027037 30446 provisioner.cpp:416] Provisioner recovery complete
I0822 16:30:45.027375 30435 slave.cpp:6226] Finished recovery
I0822 16:30:45.027906 30435 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 16:30:45.028128 30445 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 16:30:45.030189 30439 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/monitor/statistics'
I0822 16:30:45.031854 30452 http.cpp:1166] HTTP GET for /slave(805)/monitor/statistics from 172.17.0.4:38330
I0822 16:30:45.031949 30452 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0822 16:30:45.033764 30454 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (28 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0822 16:30:45.044973 9508 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 16:30:45.045480 9508 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 16:30:45.045594 9508 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 16:30:45.045630 9508 provisioner.cpp:255] Using default backend 'copy'
I0822 16:30:45.049361 30440 slave.cpp:252] Mesos agent started on (806)@172.17.0.4:33866
I0822 16:30:45.049391 30440 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_uB5lC0/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_uB5lC0/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_uB5lC0/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_uB5lC0/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_uB5lC0/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_uB5lC0/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_uB5lC0" --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_t1JEj9"
I0822 16:30:45.049913 30440 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_uB5lC0/credential'
I0822 16:30:45.050092 30440 slave.cpp:285] Agent using credential for: test-principal
I0822 16:30:45.050113 30440 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_uB5lC0/http_credentials'
I0822 16:30:45.050382 30440 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.050523 30440 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.050722 30440 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.050812 30440 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.050974 30440 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.051064 30440 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.052448 30440 slave.cpp:581] 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"}]
I0822 16:30:45.052669 30440 slave.cpp:589] Agent attributes: [ ]
I0822 16:30:45.052682 30440 slave.cpp:598] Agent hostname: 498bb002959f
I0822 16:30:45.052824 30446 status_update_manager.cpp:177] Pausing sending status updates
I0822 16:30:45.054363 30452 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_t1JEj9/meta'
I0822 16:30:45.054630 30447 status_update_manager.cpp:203] Recovering status update manager
I0822 16:30:45.054852 30443 containerizer.cpp:609] Recovering containerizer
I0822 16:30:45.056234 30435 provisioner.cpp:416] Provisioner recovery complete
I0822 16:30:45.056560 30438 slave.cpp:6226] Finished recovery
I0822 16:30:45.057133 30438 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 16:30:45.057386 30448 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 16:30:45.059932 30442 process.cpp:3933] Handling HTTP event for process 'slave(806)' with path: '/slave(806)/monitor/statistics.json'
I0822 16:30:45.061723 30447 http.cpp:1166] HTTP GET for /slave(806)/monitor/statistics.json from 172.17.0.4:38332
I0822 16:30:45.061801 30447 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0822 16:30:45.063508 30433 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (29 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0822 16:30:45.074383 9508 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 16:30:45.074903 9508 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 16:30:45.075031 9508 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 16:30:45.075062 9508 provisioner.cpp:255] Using default backend 'copy'
I0822 16:30:45.078913 30440 slave.cpp:252] Mesos agent started on (807)@172.17.0.4:33866
I0822 16:30:45.078955 30440 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_c0D23r/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_c0D23r/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_c0D23r/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_c0D23r/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_c0D23r/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_c0D23r/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_c0D23r" --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_F73ZGA"
I0822 16:30:45.079402 30440 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_c0D23r/credential'
I0822 16:30:45.079602 30440 slave.cpp:285] Agent using credential for: test-principal
I0822 16:30:45.079622 30440 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_c0D23r/http_credentials'
I0822 16:30:45.079900 30440 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.080049 30440 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.080265 30440 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.080356 30440 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.080515 30440 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.080605 30440 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.081967 30440 slave.cpp:581] 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"}]
I0822 16:30:45.082193 30440 slave.cpp:589] Agent attributes: [ ]
I0822 16:30:45.082208 30440 slave.cpp:598] Agent hostname: 498bb002959f
I0822 16:30:45.082337 30446 status_update_manager.cpp:177] Pausing sending status updates
I0822 16:30:45.084061 30455 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_F73ZGA/meta'
I0822 16:30:45.084344 30447 status_update_manager.cpp:203] Recovering status update manager
I0822 16:30:45.084523 30433 containerizer.cpp:609] Recovering containerizer
I0822 16:30:45.085886 30454 provisioner.cpp:416] Provisioner recovery complete
I0822 16:30:45.086191 30445 slave.cpp:6226] Finished recovery
I0822 16:30:45.086690 30445 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 16:30:45.086935 30451 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 16:30:45.089401 30443 process.cpp:3933] Handling HTTP event for process 'slave(807)' with path: '/slave(807)/containers'
I0822 16:30:45.091130 30450 http.cpp:1166] HTTP GET for /slave(807)/containers from 172.17.0.4:38334
I0822 16:30:45.091228 30450 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0822 16:30:45.092852 30455 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (29 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0822 16:30:45.104358 9508 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 16:30:45.104882 9508 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 16:30:45.105013 9508 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 16:30:45.105052 9508 provisioner.cpp:255] Using default backend 'copy'
I0822 16:30:45.106945 9508 cluster.cpp:448] Creating default 'local' authorizer
I0822 16:30:45.108752 30434 slave.cpp:252] Mesos agent started on (808)@172.17.0.4:33866
I0822 16:30:45.108774 30434 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uDtANT/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uDtANT/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_uDtANT/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uDtANT/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uDtANT/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_uDtANT/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_uDtANT" --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_3TY3l2"
I0822 16:30:45.109190 30434 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uDtANT/credential'
I0822 16:30:45.109391 30434 slave.cpp:285] Agent using credential for: test-principal
I0822 16:30:45.109417 30434 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uDtANT/http_credentials'
I0822 16:30:45.109725 30434 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.109874 30434 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.110113 30434 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.110224 30434 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.110399 30434 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.110489 30434 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.111948 30434 slave.cpp:581] 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"}]
I0822 16:30:45.112195 30434 slave.cpp:589] Agent attributes: [ ]
I0822 16:30:45.112210 30434 slave.cpp:598] Agent hostname: 498bb002959f
I0822 16:30:45.112341 30450 status_update_manager.cpp:177] Pausing sending status updates
I0822 16:30:45.114241 30432 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_3TY3l2/meta'
I0822 16:30:45.114526 30445 status_update_manager.cpp:203] Recovering status update manager
I0822 16:30:45.114692 30448 containerizer.cpp:609] Recovering containerizer
I0822 16:30:45.116256 30439 provisioner.cpp:416] Provisioner recovery complete
I0822 16:30:45.116587 30447 slave.cpp:6226] Finished recovery
I0822 16:30:45.117101 30447 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 16:30:45.117413 30447 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 16:30:45.119849 30444 process.cpp:3933] Handling HTTP event for process 'slave(808)' with path: '/slave(808)/monitor/statistics'
I0822 16:30:45.121683 30432 http.cpp:1166] HTTP GET for /slave(808)/monitor/statistics from 172.17.0.4:38344
I0822 16:30:45.121786 30432 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0822 16:30:45.124539 30437 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (32 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0822 16:30:45.137766 9508 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 16:30:45.138414 9508 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 16:30:45.138569 9508 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 16:30:45.138607 9508 provisioner.cpp:255] Using default backend 'copy'
I0822 16:30:45.140552 9508 cluster.cpp:448] Creating default 'local' authorizer
I0822 16:30:45.142465 30449 slave.cpp:252] Mesos agent started on (809)@172.17.0.4:33866
I0822 16:30:45.142498 30449 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_D2GkQl/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_D2GkQl/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_D2GkQl/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_D2GkQl/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_D2GkQl/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_D2GkQl/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_D2GkQl" --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_s7mUju"
I0822 16:30:45.143193 30449 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_D2GkQl/credential'
I0822 16:30:45.143473 30449 slave.cpp:285] Agent using credential for: test-principal
I0822 16:30:45.143502 30449 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_D2GkQl/http_credentials'
I0822 16:30:45.143851 30449 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.143993 30449 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.144218 30449 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.144311 30449 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.144476 30449 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.144567 30449 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.145987 30449 slave.cpp:581] 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"}]
I0822 16:30:45.146219 30449 slave.cpp:589] Agent attributes: [ ]
I0822 16:30:45.146234 30449 slave.cpp:598] Agent hostname: 498bb002959f
I0822 16:30:45.146401 30432 status_update_manager.cpp:177] Pausing sending status updates
I0822 16:30:45.148193 30433 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_s7mUju/meta'
I0822 16:30:45.148547 30446 status_update_manager.cpp:203] Recovering status update manager
I0822 16:30:45.148787 30443 containerizer.cpp:609] Recovering containerizer
I0822 16:30:45.150158 30434 provisioner.cpp:416] Provisioner recovery complete
I0822 16:30:45.150506 30437 slave.cpp:6226] Finished recovery
I0822 16:30:45.151005 30437 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 16:30:45.151335 30444 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 16:30:45.153715 30432 process.cpp:3933] Handling HTTP event for process 'slave(809)' with path: '/slave(809)/monitor/statistics.json'
I0822 16:30:45.155555 30440 http.cpp:1166] HTTP GET for /slave(809)/monitor/statistics.json from 172.17.0.4:38346
I0822 16:30:45.155643 30440 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0822 16:30:45.158378 30435 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (32 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0822 16:30:45.169458 9508 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 16:30:45.169917 9508 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 16:30:45.170024 9508 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 16:30:45.170054 9508 provisioner.cpp:255] Using default backend 'copy'
I0822 16:30:45.171701 9508 cluster.cpp:448] Creating default 'local' authorizer
I0822 16:30:45.173357 30437 slave.cpp:252] Mesos agent started on (810)@172.17.0.4:33866
I0822 16:30:45.173377 30437 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_PYGzcO/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_PYGzcO/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_PYGzcO/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_PYGzcO/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_PYGzcO/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_PYGzcO/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_PYGzcO" --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_yeMlBW"
I0822 16:30:45.173749 30437 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_PYGzcO/credential'
I0822 16:30:45.173903 30437 slave.cpp:285] Agent using credential for: test-principal
I0822 16:30:45.173924 30437 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_PYGzcO/http_credentials'
I0822 16:30:45.174185 30437 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.174305 30437 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 16:30:45.174517 30437 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.174628 30437 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 16:30:45.174839 30437 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.174945 30437 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 16:30:45.176391 30437 slave.cpp:581] 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"}]
I0822 16:30:45.176609 30437 slave.cpp:589] Agent attributes: [ ]
I0822 16:30:45.176623 30437 slave.cpp:598] Agent hostname: 498bb002959f
I0822 16:30:45.176764 30454 status_update_manager.cpp:177] Pausing sending status updates
I0822 16:30:45.178314 30445 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_yeMlBW/meta'
I0822 16:30:45.178584 30443 status_update_manager.cpp:203] Recovering status update manager
I0822 16:30:45.178746 30435 containerizer.cpp:609] Recovering containerizer
I0822 16:30:45.180232 30436 provisioner.cpp:416] Provisioner recovery complete
I0822 16:30:45.180604 30453 slave.cpp:6226] Finished recovery
I0822 16:30:45.181099 30453 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 16:30:45.181349 30432 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 16:30:45.183287 30433 process.cpp:3933] Handling HTTP event for process 'slave(810)' with path: '/slave(810)/containers'
I0822 16:30:45.184908 30446 http.cpp:1166] HTTP GET for /slave(810)/containers from 172.17.0.4:38348
I0822 16:30:45.184973 30446 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0822 16:30:45.187544 9508 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (28 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (265 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (9 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (9 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (18 ms total)
[----------] Global test environment tear-down
[==========] 1664 tests from 184 test cases ran. (645630 ms total)
[ PASSED ] 1659 tests.
[ FAILED ] 5 tests, listed below:
[ FAILED ] CommandExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckDeliveredAndReconciled
[ FAILED ] DefaultExecutorCheckTest.CommandCheckStatusChange
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSeesParentsEnv
[ FAILED ] DefaultExecutorCheckTest.CommandCheckSharesWorkDirWithTask
5 FAILED TESTS
YOU HAVE 20 DISABLED TESTS
I0822 16:30:45.268654 30456 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1503416409-11695
Untagged: mesos-1503416409-11695:latest
Deleted: sha256:522d4aa37bfd5cbb8e1693691abdeffa1c51ff50cf9f1a6d4e1d1239122a91ed
Deleted: sha256:246fff6c8a03f21609ddd6b9c8e5a6bf9f2084160138d5ae64ff62a6c28045c3
Deleted: sha256:22d11683094acbc98c37193392007285cc9c9d37c856e790b4f0427d14230288
Deleted: sha256:a89d421e3672245db0e7d7b2f626896fdb3bdffb83c44a7f9c2e2791733438e1
Deleted: sha256:e3219f345f3dd3ab6f17a610f1d302452abf1dd41773be24805b55e10ebdd968
Deleted: sha256:18a7791c4f2a6a52e4c2aa0dbb4e43ec04a4b67f141cf11fb6d870ec22fc1e0f
Deleted: sha256:d5b3e72613e7ae45a1c3e9248dcf01e6972130eb733b177ee8f13cff8b7d98ea
Deleted: sha256:bdea252abca155c770e68b3f84eddf9f68b09c05afb62f18194c93cc23d31328
Deleted: sha256:e0605698c8102db4e7c445652218d807c7f752edd1f6d40b262108368b4ba87a
Deleted: sha256:668b9c7bff55d793868abb8e12d9dfe9343689e695dc27fea20cd497434eb81b
Deleted: sha256:1cc5847127933cfa7d2ba9aad224417bcbc599ce0018276db39edffba08025f5
Deleted: sha256:b0a89c508a7607182b139b2b88cc9d2e1bfddac20f8e6eecef1de3169bbf17a1
Deleted: sha256:abeed74fef9b06c2cc5a963c89b767a3b4d5963b2aa5f83ae55c98adc3b22367
Deleted: sha256:a112a6d15115d5904e39d70f5a6fdd46e4e05e22139545cc63b89188bc6e88e0
Deleted: sha256:907240ed38c46f21d9049a1c82ab3c0b76f32d166230ad1c5ef4c8757e0bbe62
Deleted: sha256:23db794b6ddb026ac54af9e45a5a220f447674f7c7620c856f6d9f11814e8773
Deleted: sha256:81d1aa4eca75be478f3bea3a4cd729f75caf736739a16c3361e490040c47d1c8
Deleted: sha256:eae19eda08224a30fc9518192f5630ed9968722f63fb2928a4f00d52a95f8c10
Deleted: sha256:b339983d3cca77371ed6f9e782810795d0ab4ef63d99691cf72e88840d101188
Deleted: sha256:fa72c94498c8272e33268aacb3a9226b40bbbe1d201741f1c69ae011d65f0cda
Deleted: sha256:aa95422b20ecb12433bd4c5d44b921e572d61c3010792ca2596bb7dd88dac09c
Deleted: sha256:32761bea6ab476f481533bbb2c9ed1bfe8b3886f6fa95ac6e07d72c2dd97a68f
Deleted: sha256:867223dad8a29bffd8ab6afefb3c8acb027754c93e8dd81a35bfd4a3cb317c2d
Deleted: sha256:e1f047b941ffb728242f206924192fb8d4170a006c0438cc15282bcca6ced69b
Deleted: sha256:ff605aed58513316df4fa34d7b638aa4e60cc627ad1028ee9d68a01e7d91bea1
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user xujyan@apple.com
Not sending mail to unregistered user gregorywmann@gmail.com
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4138
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4138/display/redirect?page=changes>
Changes:
[alexr] Fixed a typo in the networking doc.
[alexr] Fixed a typo in provisioner.
------------------------------------------
[...truncated 16.09 MB...]
I0822 11:17:10.852759 9544 master.cpp:5865] Registering agent at slave(324)@172.17.0.3:35765 (3909931565c1) with id 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
I0822 11:17:10.853246 9547 registrar.cpp:495] Applied 1 operations in 90568ns; attempting to update the registry
I0822 11:17:10.854176 9547 registrar.cpp:552] Successfully updated the registry in 0ns
I0822 11:17:10.854379 9546 master.cpp:5912] Admitted agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:10.854976 9558 slave.cpp:4903] Received ping from slave-observer(322)@172.17.0.3:35765
I0822 11:17:10.854933 9546 master.cpp:5943] Registered agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) 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"}]
I0822 11:17:10.855204 9558 slave.cpp:1190] Registered with master master@172.17.0.3:35765; given agent ID 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
I0822 11:17:10.855360 9552 status_update_manager.cpp:184] Resuming sending status updates
I0822 11:17:10.855517 9545 hierarchical.cpp:593] Added agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 (3909931565c1) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0822 11:17:10.855615 9558 slave.cpp:1210] Checkpointing SlaveInfo to '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/meta/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/slave.info'
I0822 11:17:10.855979 9558 slave.cpp:1248] Forwarding total oversubscribed resources {}
I0822 11:17:10.856186 9560 master.cpp:6688] Received update of agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) with total oversubscribed resources {}
I0822 11:17:10.857208 9545 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:10.857249 9545 hierarchical.cpp:1486] Performed allocation for 1 agents in 1.498287ms
I0822 11:17:10.857399 9545 hierarchical.cpp:660] Agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 (3909931565c1) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0822 11:17:10.857645 9542 master.cpp:7667] Sending 1 offers to framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:10.858238 9548 sched.cpp:933] Scheduler::resourceOffers took 89414ns
I0822 11:17:10.859762 9557 master.cpp:9164] Removing offer 0d77a5e8-5906-4f97-9059-5e224479a22f-O0
I0822 11:17:10.859891 9557 master.cpp:4153] Processing ACCEPT call for offers: [ 0d77a5e8-5906-4f97-9059-5e224479a22f-O0 ] on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:10.859987 9557 master.cpp:3530] Authorizing framework principal 'test-principal' to launch task 74674011-c553-4c0e-abd1-d42eb79c8693
I0822 11:17:10.862051 9550 master.cpp:9724] Adding task 74674011-c553-4c0e-abd1-d42eb79c8693 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:10.862589 9550 master.cpp:4816] Launching task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:10.863442 9540 slave.cpp:1717] Got assigned task '74674011-c553-4c0e-abd1-d42eb79c8693' for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:10.864086 9540 slave.cpp:1998] Authorizing task '74674011-c553-4c0e-abd1-d42eb79c8693' for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:10.864143 9540 slave.cpp:6725] Authorizing framework principal 'test-principal' to launch task 74674011-c553-4c0e-abd1-d42eb79c8693
I0822 11:17:10.864413 9554 hierarchical.cpp:887] Updated allocation of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-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]
I0822 11:17:10.864850 9540 slave.cpp:2185] Launching task '74674011-c553-4c0e-abd1-d42eb79c8693' for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:10.865377 9540 paths.cpp:578] Trying to chown '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693/runs/e5b797b2-2676-4749-be70-54498b303033' to user 'mesos'
I0822 11:17:10.865609 9540 slave.cpp:7181] Launching executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":32.0},"type":"SCALAR"}] in work directory '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693/runs/e5b797b2-2676-4749-be70-54498b303033'
I0822 11:17:10.866503 9540 slave.cpp:2414] Queued task '74674011-c553-4c0e-abd1-d42eb79c8693' for executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:10.866614 9540 slave.cpp:940] Successfully attached file '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693/runs/e5b797b2-2676-4749-be70-54498b303033'
I0822 11:17:10.866914 9540 slave.cpp:2872] Launching container e5b797b2-2676-4749-be70-54498b303033 for executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:10.867235 9540 slave.cpp:940] Successfully attached file '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693/runs/e5b797b2-2676-4749-be70-54498b303033'
I0822 11:17:10.867298 9543 containerizer.cpp:1083] Starting container e5b797b2-2676-4749-be70-54498b303033
I0822 11:17:10.868067 9543 containerizer.cpp:2673] Transitioning the state of container e5b797b2-2676-4749-be70-54498b303033 from PROVISIONING to PREPARING
I0822 11:17:10.872354 9563 containerizer.cpp:1657] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["mesos-executor","--launcher_dir=\/mesos\/mesos-1.5.0\/_build\/src"],"shell":false,"value":"\/mesos\/mesos-1.5.0\/_build\/src\/mesos-executor"},"environment":{"variables":[{"name":"LIBPROCESS_PORT","type":"VALUE","value":"0"},{"name":"MESOS_AGENT_ENDPOINT","type":"VALUE","value":"172.17.0.3:35765"},{"name":"MESOS_CHECKPOINT","type":"VALUE","value":"0"},{"name":"MESOS_DIRECTORY","type":"VALUE","value":"\/tmp\/PartitionTest_ReregisterSlavePartitionAware_QehWuH\/slaves\/0d77a5e8-5906-4f97-9059-5e224479a22f-S0\/frameworks\/0d77a5e8-5906-4f97-9059-5e224479a22f-0000\/executors\/74674011-c553-4c0e-abd1-d42eb79c8693\/runs\/e5b797b2-2676-4749-be70-54498b303033"},{"name":"MESOS_EXECUTOR_AUTHENTICATION_TOKEN","type":"VALUE","value":"eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJjaWQiOiJlNWI3OTdiMi0yNjc2LTQ3NDktYmU3MC01NDQ5OGIzMDMwMzMiLCJlaWQiOiI3NDY3NDAxMS1jNTUzLTRjMGUtYWJkMS1kNDJlYjc5Yzg2OTMiLCJmaWQiOiIwZDc3YTVlOC01OTA2LTRmOTctOTA1OS01ZTIyNDQ3OWEyMmYtMDAwMCJ9.edm2qwT9aaLGBtxAYYM2-JtM2a47sNNYygLgYl2L_sw"},{"name":"MESOS_EXECUTOR_ID","type":"VALUE","value":"74674011-c553-4c0e-abd1-d42eb79c8693"},{"name":"MESOS_EXECUTOR_SHUTDOWN_GRACE_PERIOD","type":"VALUE","value":"5secs"},{"name":"MESOS_FRAMEWORK_ID","type":"VALUE","value":"0d77a5e8-5906-4f97-9059-5e224479a22f-0000"},{"name":"MESOS_HTTP_COMMAND_EXECUTOR","type":"VALUE","value":"0"},{"name":"MESOS_SLAVE_ID","type":"VALUE","value":"0d77a5e8-5906-4f97-9059-5e224479a22f-S0"},{"name":"MESOS_SLAVE_PID","type":"VALUE","value":"slave(324)@172.17.0.3:35765"},{"name":"MESOS_SANDBOX","type":"VALUE","value":"\/tmp\/PartitionTest_ReregisterSlavePartitionAware_QehWuH\/slaves\/0d77a5e8-5906-4f97-9059-5e224479a22f-S0\/frameworks\/0d77a5e8-5906-4f97-9059-5e224479a22f-0000\/executors\/74674011-c553-4c0e-abd1-d42eb79c8693\/runs\/e5b797b2-2676-4749-be70-54498b303033"}]},"task_environment":{},"user":"mesos","working_directory":"\/tmp\/PartitionTest_ReregisterSlavePartitionAware_QehWuH\/slaves\/0d77a5e8-5906-4f97-9059-5e224479a22f-S0\/frameworks\/0d77a5e8-5906-4f97-9059-5e224479a22f-0000\/executors\/74674011-c553-4c0e-abd1-d42eb79c8693\/runs\/e5b797b2-2676-4749-be70-54498b303033"}" --pipe_read="16" --pipe_write="17" --runtime_directory="/tmp/PartitionTest_ReregisterSlavePartitionAware_nYUTcQ/containers/e5b797b2-2676-4749-be70-54498b303033" --unshare_namespace_mnt="false"'
I0822 11:17:10.876255 9563 launcher.cpp:140] Forked child with pid '21141' for container 'e5b797b2-2676-4749-be70-54498b303033'
I0822 11:17:10.876930 9563 containerizer.cpp:2673] Transitioning the state of container e5b797b2-2676-4749-be70-54498b303033 from PREPARING to ISOLATING
I0822 11:17:10.879024 9563 containerizer.cpp:2673] Transitioning the state of container e5b797b2-2676-4749-be70-54498b303033 from ISOLATING to FETCHING
I0822 11:17:10.879426 9558 fetcher.cpp:377] Starting to fetch URIs for container: e5b797b2-2676-4749-be70-54498b303033, directory: /tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693/runs/e5b797b2-2676-4749-be70-54498b303033
I0822 11:17:10.880599 9560 containerizer.cpp:2673] Transitioning the state of container e5b797b2-2676-4749-be70-54498b303033 from FETCHING to RUNNING
I0822 11:17:11.106057 21184 exec.cpp:162] Version: 1.5.0
I0822 11:17:11.118191 9559 slave.cpp:3897] Got registration for executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 from executor(1)@172.17.0.3:39867
I0822 11:17:11.121191 9562 slave.cpp:2619] Sending queued task '74674011-c553-4c0e-abd1-d42eb79c8693' to executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 at executor(1)@172.17.0.3:39867
I0822 11:17:11.122961 21172 exec.cpp:237] Executor registered on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
I0822 11:17:11.126317 21175 executor.cpp:171] Received SUBSCRIBED event
I0822 11:17:11.128540 21175 executor.cpp:175] Subscribed executor on 3909931565c1
I0822 11:17:11.128942 21175 executor.cpp:171] Received LAUNCH event
I0822 11:17:11.129252 21175 executor.cpp:633] Starting task 74674011-c553-4c0e-abd1-d42eb79c8693
I0822 11:17:11.157032 21175 executor.cpp:477] Running '/mesos/mesos-1.5.0/_build/src/mesos-containerizer launch <POSSIBLY-SENSITIVE-DATA>'
I0822 11:17:11.161044 21175 executor.cpp:646] Forked command at 21194
I0822 11:17:11.166945 9540 slave.cpp:4361] Handling status update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 from executor(1)@172.17.0.3:39867
I0822 11:17:11.169142 9550 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.169229 9550 status_update_manager.cpp:500] Creating StatusUpdate stream for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.169883 9550 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 to the agent
I0822 11:17:11.170330 9550 slave.cpp:4813] Forwarding the update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 to master@172.17.0.3:35765
I0822 11:17:11.170627 9550 slave.cpp:4707] Status update manager successfully handled status update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.170681 9550 slave.cpp:4723] Sending acknowledgement for status update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 to executor(1)@172.17.0.3:39867
I0822 11:17:11.170835 9554 master.cpp:6846] Status update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 from agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.170907 9554 master.cpp:6908] Forwarding status update TASK_RUNNING (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.171422 9561 sched.cpp:1041] Scheduler::statusUpdate took 89403ns
I0822 11:17:11.171630 9554 master.cpp:8933] Updating the state of task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0822 11:17:11.171838 9554 master.cpp:5477] Processing ACKNOWLEDGE call 8328a115-73f5-44d0-8fa4-228cd7ac0220 for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765 on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
I0822 11:17:11.172334 9556 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.172643 9546 slave.cpp:3625] Status update manager successfully handled status update acknowledgement (UUID: 8328a115-73f5-44d0-8fa4-228cd7ac0220) for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.174139 9562 hierarchical.cpp:1943] No allocations performed
I0822 11:17:11.174208 9562 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:11.174213 9542 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 11:17:11.174263 9562 hierarchical.cpp:1486] Performed allocation for 1 agents in 291055ns
I0822 11:17:11.174567 9542 slave.cpp:4903] Received ping from slave-observer(322)@172.17.0.3:35765
I0822 11:17:11.174789 9542 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 11:17:11.175529 9557 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 11:17:11.175701 9543 hierarchical.cpp:1943] No allocations performed
I0822 11:17:11.175712 9557 slave.cpp:4903] Received ping from slave-observer(322)@172.17.0.3:35765
I0822 11:17:11.175755 9543 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:11.175830 9543 hierarchical.cpp:1486] Performed allocation for 1 agents in 274591ns
I0822 11:17:11.175864 9557 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 11:17:11.176519 9551 hierarchical.cpp:1943] No allocations performed
I0822 11:17:11.176558 9551 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:11.176606 9551 hierarchical.cpp:1486] Performed allocation for 1 agents in 169070ns
I0822 11:17:11.176800 9550 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 11:17:11.176913 9550 slave.cpp:4903] Received ping from slave-observer(322)@172.17.0.3:35765
I0822 11:17:11.177186 9561 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 11:17:11.177978 9546 hierarchical.cpp:1943] No allocations performed
I0822 11:17:11.177990 9547 slave.cpp:5851] Current disk usage 37.07%. Max allowed age: 3.704939371751528days
I0822 11:17:11.178030 9546 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:11.178117 9546 hierarchical.cpp:1486] Performed allocation for 1 agents in 242641ns
I0822 11:17:11.178172 9547 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 11:17:11.178323 9547 slave.cpp:4903] Received ping from slave-observer(322)@172.17.0.3:35765
I0822 11:17:11.178588 9562 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 11:17:11.179127 9548 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 11:17:11.179241 9560 hierarchical.cpp:1943] No allocations performed
I0822 11:17:11.179292 9560 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:11.179342 9560 hierarchical.cpp:1486] Performed allocation for 1 agents in 228030ns
I0822 11:17:11.179397 9559 master.cpp:7067] Marking agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) unreachable: health check timed out
I0822 11:17:11.179416 9548 slave.cpp:4903] Received ping from slave-observer(322)@172.17.0.3:35765
I0822 11:17:11.179769 9548 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 11:17:11.180003 9549 registrar.cpp:495] Applied 1 operations in 110065ns; attempting to update the registry
I0822 11:17:11.180989 9549 registrar.cpp:552] Successfully updated the registry in 0ns
I0822 11:17:11.181285 9554 master.cpp:7115] Marked agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) unreachable: health check timed out
I0822 11:17:11.181511 9554 master.cpp:8933] Updating the state of task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (latest state: TASK_UNREACHABLE, status update state: TASK_UNREACHABLE)
I0822 11:17:11.182122 9561 hierarchical.cpp:626] Removed agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
I0822 11:17:11.182296 9554 master.cpp:9027] Removing task 74674011-c553-4c0e-abd1-d42eb79c8693 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.182865 9554 master.cpp:6903] Sending status update TASK_UNREACHABLE for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 'Agent 3909931565c1 is unreachable: health check timed out'
I0822 11:17:11.183315 9545 sched.cpp:1041] Scheduler::statusUpdate took 50875ns
I0822 11:17:11.183441 9554 master.cpp:2080] Notifying framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765 of lost agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 (3909931565c1)
I0822 11:17:11.183691 9558 sched.cpp:1103] Lost agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
I0822 11:17:11.183758 9558 sched.cpp:1114] Scheduler::slaveLost took 25522ns
I0822 11:17:11.186084 9560 process.cpp:3933] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot'
I0822 11:17:11.187186 9543 http.cpp:832] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot'
I0822 11:17:11.208647 9546 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/state'
I0822 11:17:11.210127 9563 http.cpp:1166] HTTP GET for /master/state from 172.17.0.3:51382
I0822 11:17:11.222084 9542 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/tasks'
I0822 11:17:11.224052 9563 http.cpp:1166] HTTP GET for /master/tasks from 172.17.0.3:51384
I0822 11:17:11.232189 9560 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/state-summary'
I0822 11:17:11.233507 9550 http.cpp:1166] HTTP GET for /master/state-summary from 172.17.0.3:51386
I0822 11:17:11.241017 9546 slave.cpp:980] Lost leading master
I0822 11:17:11.241056 9540 status_update_manager.cpp:177] Pausing sending status updates
I0822 11:17:11.241073 9546 slave.cpp:1022] Detecting new master
I0822 11:17:11.241420 9542 status_update_manager.cpp:177] Pausing sending status updates
I0822 11:17:11.241446 9541 slave.cpp:987] New master detected at master@172.17.0.3:35765
I0822 11:17:11.241572 9541 slave.cpp:1022] Detecting new master
I0822 11:17:11.241703 9541 slave.cpp:1049] Authenticating with master master@172.17.0.3:35765
I0822 11:17:11.241780 9541 slave.cpp:1060] Using default CRAM-MD5 authenticatee
I0822 11:17:11.242125 9548 authenticatee.cpp:121] Creating new client SASL connection
I0822 11:17:11.242501 9548 master.cpp:7837] Authenticating slave(324)@172.17.0.3:35765
I0822 11:17:11.242664 9556 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(689)@172.17.0.3:35765
I0822 11:17:11.243059 9551 authenticator.cpp:98] Creating new server SASL connection
I0822 11:17:11.243331 9550 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0822 11:17:11.243366 9550 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0822 11:17:11.243548 9550 authenticator.cpp:204] Received SASL authentication start
I0822 11:17:11.243647 9550 authenticator.cpp:326] Authentication requires more steps
I0822 11:17:11.243855 9550 authenticatee.cpp:259] Received SASL authentication step
I0822 11:17:11.244041 9549 authenticator.cpp:232] Received SASL authentication step
I0822 11:17:11.244073 9549 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3909931565c1' server FQDN: '3909931565c1' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0822 11:17:11.244091 9549 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0822 11:17:11.244171 9549 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0822 11:17:11.244210 9549 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3909931565c1' server FQDN: '3909931565c1' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0822 11:17:11.244227 9549 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0822 11:17:11.244315 9549 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0822 11:17:11.244369 9549 authenticator.cpp:318] Authentication success
I0822 11:17:11.244595 9547 authenticatee.cpp:299] Authentication success
I0822 11:17:11.244637 9544 master.cpp:7867] Successfully authenticated principal 'test-principal' at slave(324)@172.17.0.3:35765
I0822 11:17:11.244607 9554 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(689)@172.17.0.3:35765
I0822 11:17:11.245165 9547 slave.cpp:1144] Successfully authenticated with master master@172.17.0.3:35765
I0822 11:17:11.245926 9547 slave.cpp:1588] Will retry registration in 18.513176ms if necessary
I0822 11:17:11.246747 9547 master.cpp:6012] Received re-register agent message from agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.247087 9547 master.cpp:3803] Authorizing agent with principal 'test-principal'
I0822 11:17:11.247898 9540 master.cpp:6081] Authorized re-registration of agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.248037 9540 master.cpp:6217] Re-registering agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.248715 9546 registrar.cpp:495] Applied 1 operations in 81470ns; attempting to update the registry
I0822 11:17:11.249583 9546 registrar.cpp:552] Successfully updated the registry in 0ns
I0822 11:17:11.250155 9559 master.cpp:6286] Re-admitted agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.250811 9559 master.cpp:9724] Adding task 74674011-c553-4c0e-abd1-d42eb79c8693 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.251723 9551 slave.cpp:4903] Received ping from slave-observer(323)@172.17.0.3:35765
I0822 11:17:11.252315 9551 slave.cpp:1291] Re-registered with master master@172.17.0.3:35765
I0822 11:17:11.252089 9559 master.cpp:6471] Re-registered agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) 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"}]
I0822 11:17:11.252651 9549 status_update_manager.cpp:184] Resuming sending status updates
I0822 11:17:11.252651 9559 master.cpp:6586] Sending updated checkpointed resources {} to agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.252682 9551 slave.cpp:1328] Forwarding total oversubscribed resources {}
I0822 11:17:11.252895 9559 master.cpp:6688] Received update of agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) with total oversubscribed resources {}
I0822 11:17:11.252939 9551 slave.cpp:3346] Updating info for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 with pid updated to scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:11.253325 9544 status_update_manager.cpp:184] Resuming sending status updates
I0822 11:17:11.253293 9557 hierarchical.cpp:593] Added agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 (3909931565c1) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000])
I0822 11:17:11.253434 9551 slave.cpp:3410] Ignoring new checkpointed resources identical to the current version: {}
I0822 11:17:11.253636 9557 hierarchical.cpp:660] Agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 (3909931565c1) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0822 11:17:11.253891 9557 hierarchical.cpp:1943] No allocations performed
I0822 11:17:11.253947 9557 hierarchical.cpp:2033] No inverse offers to send out!
I0822 11:17:11.253998 9557 hierarchical.cpp:1486] Performed allocation for 1 agents in 229926ns
I0822 11:17:11.254739 9545 master.cpp:7346] Performing explicit task state reconciliation for 1 tasks of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:11.254987 9545 master.cpp:7475] Sending explicit reconciliation state TASK_RUNNING for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:11.255415 9553 sched.cpp:1041] Scheduler::statusUpdate took 78258ns
I0822 11:17:11.258298 9543 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/state'
I0822 11:17:11.259739 9550 http.cpp:1166] HTTP GET for /master/state from 172.17.0.3:51392
I0822 11:17:11.269498 9557 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/tasks'
I0822 11:17:11.271232 9558 http.cpp:1166] HTTP GET for /master/tasks from 172.17.0.3:51398
I0822 11:17:11.277971 9542 process.cpp:3933] Handling HTTP event for process 'master' with path: '/master/state-summary'
I0822 11:17:11.279629 9556 http.cpp:1166] HTTP GET for /master/state-summary from 172.17.0.3:51400
I0822 11:17:11.286005 9545 process.cpp:3933] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot'
I0822 11:17:11.287089 9557 http.cpp:832] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot'
I0822 11:17:11.305899 9521 sched.cpp:2021] Asked to stop the driver
I0822 11:17:11.306037 9541 sched.cpp:1203] Stopping framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.306462 9554 master.cpp:8348] Processing TEARDOWN call for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:11.306496 9554 master.cpp:8360] Removing framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:11.306516 9554 master.cpp:3264] Deactivating framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (default) at scheduler-c83cf1b8-e786-4879-8f83-2a479d58db3f@172.17.0.3:35765
I0822 11:17:11.306771 9554 master.cpp:8933] Updating the state of task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0822 11:17:11.306923 9540 slave.cpp:3175] Asked to shut down framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 by master@172.17.0.3:35765
I0822 11:17:11.306921 9563 hierarchical.cpp:412] Deactivated framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.307415 9540 slave.cpp:3200] Shutting down framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.307837 9558 containerizer.cpp:2132] Destroying container e5b797b2-2676-4749-be70-54498b303033 in RUNNING state
I0822 11:17:11.307927 9558 containerizer.cpp:2673] Transitioning the state of container e5b797b2-2676-4749-be70-54498b303033 from RUNNING to DESTROYING
I0822 11:17:11.307865 9540 slave.cpp:5667] Shutting down executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 at executor(1)@172.17.0.3:39867
I0822 11:17:11.308298 9558 launcher.cpp:156] Asked to destroy container e5b797b2-2676-4749-be70-54498b303033
I0822 11:17:11.307992 9554 master.cpp:9027] Removing task 74674011-c553-4c0e-abd1-d42eb79c8693 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.309360 9563 hierarchical.cpp:1161] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 from framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.309619 21176 exec.cpp:435] Executor asked to shutdown
I0822 11:17:11.309835 9563 hierarchical.cpp:355] Removed framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.310076 21186 executor.cpp:171] Received SHUTDOWN event
I0822 11:17:11.310128 21186 executor.cpp:743] Shutting down
I0822 11:17:11.310191 21186 executor.cpp:850] Sending SIGTERM to process tree at pid 21194
I0822 11:17:11.318861 9541 slave.cpp:4945] Got exited event for executor(1)@172.17.0.3:39867
I0822 11:17:11.357707 9552 containerizer.cpp:2573] Container e5b797b2-2676-4749-be70-54498b303033 has exited
I0822 11:17:11.360258 9540 provisioner.cpp:490] Ignoring destroy request for unknown container e5b797b2-2676-4749-be70-54498b303033
I0822 11:17:11.360976 9557 slave.cpp:5345] Executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 terminated with signal Killed
I0822 11:17:11.361050 9557 slave.cpp:5445] Cleaning up executor '74674011-c553-4c0e-abd1-d42eb79c8693' of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000 at executor(1)@172.17.0.3:39867
I0822 11:17:11.361312 9559 gc.cpp:59] Scheduling '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693/runs/e5b797b2-2676-4749-be70-54498b303033' for gc 6.99999581932741days in the future
I0822 11:17:11.361459 9557 slave.cpp:5541] Cleaning up framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.361521 9559 gc.cpp:59] Scheduling '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000/executors/74674011-c553-4c0e-abd1-d42eb79c8693' for gc 6.99999581733926days in the future
I0822 11:17:11.361577 9546 status_update_manager.cpp:285] Closing status update streams for framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.361636 9546 status_update_manager.cpp:531] Cleaning up status update stream for task 74674011-c553-4c0e-abd1-d42eb79c8693 of framework 0d77a5e8-5906-4f97-9059-5e224479a22f-0000
I0822 11:17:11.361644 9559 gc.cpp:59] Scheduling '/tmp/PartitionTest_ReregisterSlavePartitionAware_QehWuH/slaves/0d77a5e8-5906-4f97-9059-5e224479a22f-S0/frameworks/0d77a5e8-5906-4f97-9059-5e224479a22f-0000' for gc 6.9999958153363days in the future
I0822 11:17:11.361766 9562 slave.cpp:859] Agent terminating
I0822 11:17:11.362030 9555 master.cpp:1318] Agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1) disconnected
I0822 11:17:11.362061 9555 master.cpp:3301] Disconnecting agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.362116 9555 master.cpp:3320] Deactivating agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 at slave(324)@172.17.0.3:35765 (3909931565c1)
I0822 11:17:11.362231 9545 hierarchical.cpp:690] Agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0 deactivated
I0822 11:17:11.367720 9521 master.cpp:1160] Master terminating
I0822 11:17:11.368605 9558 hierarchical.cpp:626] Removed agent 0d77a5e8-5906-4f97-9059-5e224479a22f-S0
[ OK ] PartitionTest.ReregisterSlavePartitionAware (559 ms)
[ RUN ] PartitionTest.ReregisterSlaveNotPartitionAware
I0822 11:17:11.375658 9521 cluster.cpp:162] Creating default 'local' authorizer
I0822 11:17:11.379014 9545 master.cpp:442] Master 9d37f902-3600-4635-8e4c-c7353f37f6a0 (3909931565c1) started on 172.17.0.3:35765
I0822 11:17:11.379036 9545 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/x9bWmz/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.5.0/_inst/share/mesos/webui" --work_dir="/tmp/x9bWmz/master" --zk_session_timeout="10secs"
I0822 11:17:11.379407 9545 master.cpp:494] Master only allowing authenticated frameworks to register
I0822 11:17:11.379418 9545 master.cpp:508] Master only allowing authenticated agents to register
I0822 11:17:11.379425 9545 master.cpp:521] Master only allowing authenticated HTTP frameworks to register
I0822 11:17:11.379434 9545 credentials.hpp:37] Loading credentials for authentication from '/tmp/x9bWmz/credentials'
I0822 11:17:11.379740 9545 master.cpp:566] Using default 'crammd5' authenticator
I0822 11:17:11.379904 9545 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0822 11:17:11.380146 9545 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0822 11:17:11.380331 9545 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0822 11:17:11.380461 9545 master.cpp:646] Authorization enabled
I0822 11:17:11.380635 9563 hierarchical.cpp:171] Initialized hierarchical allocator process
I0822 11:17:11.380668 9548 whitelist_watcher.cpp:77] No whitelist given
I0822 11:17:11.383569 9554 master.cpp:2163] Elected as the leading master!
I0822 11:17:11.383613 9554 master.cpp:1702] Recovering from registrar
I0822 11:17:11.383841 9562 registrar.cpp:347] Recovering registrar
I0822 11:17:11.384624 9562 registrar.cpp:391] Successfully fetched the registry (0B) in 0ns
I0822 11:17:11.384757 9562 registrar.cpp:495] Applied 1 operations in 38756ns; attempting to update the registry
I0822 11:17:11.385447 9562 registrar.cpp:552] Successfully updated the registry in 0ns
I0822 11:17:11.385589 9562 registrar.cpp:424] Successfully recovered registrar
I0822 11:17:11.385941 9546 master.cpp:1801] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0822 11:17:11.385967 9557 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
Build timed out (after 300 minutes). Marking the build as failed.
Build was aborted
++ docker rmi mesos-1503398196-18252
Error response from daemon: conflict: unable to remove repository reference "mesos-1503398196-18252" (must force) - container 3909931565c1 is using its referenced image 1c1fd3685f36
Not sending mail to unregistered user xujyan@apple.com
Not sending mail to unregistered user gregorywmann@gmail.com
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #4137
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/4137/display/redirect>
------------------------------------------
[...truncated 31.96 MB...]
I0822 06:26:57.735913 8685 provisioner.cpp:255] Using default backend 'copy'
I0822 06:26:57.739727 26764 slave.cpp:252] Mesos agent started on (805)@172.17.0.3:46296
I0822 06:26:57.739758 26764 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_RtiqxW/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_RtiqxW/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_RtiqxW/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_RtiqxW/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_RtiqxW/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_RtiqxW/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_RtiqxW" --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_CGWrKD"
I0822 06:26:57.740406 26764 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_RtiqxW/credential'
I0822 06:26:57.740597 26764 slave.cpp:285] Agent using credential for: test-principal
I0822 06:26:57.740625 26764 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_RtiqxW/http_credentials'
I0822 06:26:57.741011 26764 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.741160 26764 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.741438 26764 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.741601 26764 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.741868 26764 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.742005 26764 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.743886 26764 slave.cpp:581] 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"}]
I0822 06:26:57.744191 26764 slave.cpp:589] Agent attributes: [ ]
I0822 06:26:57.744207 26764 slave.cpp:598] Agent hostname: d3357831f8b1
I0822 06:26:57.744416 26765 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:26:57.746338 26773 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_CGWrKD/meta'
I0822 06:26:57.746789 26777 status_update_manager.cpp:203] Recovering status update manager
I0822 06:26:57.747061 26777 containerizer.cpp:609] Recovering containerizer
I0822 06:26:57.748893 26766 provisioner.cpp:416] Provisioner recovery complete
I0822 06:26:57.749380 26769 slave.cpp:6226] Finished recovery
I0822 06:26:57.749879 26769 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:26:57.750195 26769 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:26:57.752758 26770 process.cpp:3933] Handling HTTP event for process 'slave(805)' with path: '/slave(805)/monitor/statistics'
I0822 06:26:57.755013 26771 http.cpp:1166] HTTP GET for /slave(805)/monitor/statistics from 172.17.0.3:57588
I0822 06:26:57.755096 26771 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0822 06:26:57.757623 8685 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (37 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0822 06:26:57.772147 8685 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 06:26:57.772784 8685 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 06:26:57.772920 8685 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 06:26:57.772960 8685 provisioner.cpp:255] Using default backend 'copy'
I0822 06:26:57.776528 26774 slave.cpp:252] Mesos agent started on (806)@172.17.0.3:46296
I0822 06:26:57.776556 26774 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZcmQ19/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZcmQ19/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_ZcmQ19/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZcmQ19/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZcmQ19/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_ZcmQ19/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_ZcmQ19" --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_mMDR8Q"
I0822 06:26:57.777112 26774 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZcmQ19/credential'
I0822 06:26:57.777289 26774 slave.cpp:285] Agent using credential for: test-principal
I0822 06:26:57.777315 26774 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZcmQ19/http_credentials'
I0822 06:26:57.777801 26774 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.777947 26774 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.778230 26774 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.778375 26774 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.778654 26774 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.778796 26774 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.780735 26774 slave.cpp:581] 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"}]
I0822 06:26:57.781038 26774 slave.cpp:589] Agent attributes: [ ]
I0822 06:26:57.781056 26774 slave.cpp:598] Agent hostname: d3357831f8b1
I0822 06:26:57.781234 26768 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:26:57.782905 26767 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_mMDR8Q/meta'
I0822 06:26:57.783385 26764 status_update_manager.cpp:203] Recovering status update manager
I0822 06:26:57.783558 26764 containerizer.cpp:609] Recovering containerizer
I0822 06:26:57.785001 26770 provisioner.cpp:416] Provisioner recovery complete
I0822 06:26:57.785542 26762 slave.cpp:6226] Finished recovery
I0822 06:26:57.786054 26762 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:26:57.786355 26765 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:26:57.789011 26769 process.cpp:3933] Handling HTTP event for process 'slave(806)' with path: '/slave(806)/monitor/statistics.json'
I0822 06:26:57.791195 26771 http.cpp:1166] HTTP GET for /slave(806)/monitor/statistics.json from 172.17.0.3:57589
I0822 06:26:57.791275 26771 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0822 06:26:57.794061 26775 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (35 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0822 06:26:57.807247 8685 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 06:26:57.807832 8685 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 06:26:57.807965 8685 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 06:26:57.808004 8685 provisioner.cpp:255] Using default backend 'copy'
I0822 06:26:57.812335 26772 slave.cpp:252] Mesos agent started on (807)@172.17.0.3:46296
I0822 06:26:57.812360 26772 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_5Y1hTn/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_5Y1hTn/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_5Y1hTn/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_5Y1hTn/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_5Y1hTn/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_5Y1hTn/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_5Y1hTn" --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_ALOAU4"
I0822 06:26:57.812779 26772 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_5Y1hTn/credential'
I0822 06:26:57.812919 26772 slave.cpp:285] Agent using credential for: test-principal
I0822 06:26:57.812940 26772 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_5Y1hTn/http_credentials'
I0822 06:26:57.813207 26772 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.813323 26772 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.813567 26772 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.813696 26772 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.813942 26772 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.814090 26772 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.815887 26772 slave.cpp:581] 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"}]
I0822 06:26:57.816191 26772 slave.cpp:589] Agent attributes: [ ]
I0822 06:26:57.816207 26772 slave.cpp:598] Agent hostname: d3357831f8b1
I0822 06:26:57.816432 26766 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:26:57.818045 26774 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_ALOAU4/meta'
I0822 06:26:57.818404 26769 status_update_manager.cpp:203] Recovering status update manager
I0822 06:26:57.818629 26769 containerizer.cpp:609] Recovering containerizer
I0822 06:26:57.820358 26767 provisioner.cpp:416] Provisioner recovery complete
I0822 06:26:57.820834 26770 slave.cpp:6226] Finished recovery
I0822 06:26:57.821352 26770 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:26:57.821727 26774 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:26:57.824398 26768 process.cpp:3933] Handling HTTP event for process 'slave(807)' with path: '/slave(807)/containers'
I0822 06:26:57.826690 26777 http.cpp:1166] HTTP GET for /slave(807)/containers from 172.17.0.3:57590
I0822 06:26:57.826781 26777 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0822 06:26:57.829303 26762 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (34 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0822 06:26:57.842768 8685 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 06:26:57.843344 8685 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 06:26:57.843474 8685 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 06:26:57.843514 8685 provisioner.cpp:255] Using default backend 'copy'
I0822 06:26:57.845726 8685 cluster.cpp:448] Creating default 'local' authorizer
I0822 06:26:57.847422 26771 slave.cpp:252] Mesos agent started on (808)@172.17.0.3:46296
I0822 06:26:57.847452 26771 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_jPyB7B/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_jPyB7B/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_jPyB7B/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_jPyB7B/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_jPyB7B/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_jPyB7B/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_jPyB7B" --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_g8Kc3i"
I0822 06:26:57.848022 26771 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_jPyB7B/credential'
I0822 06:26:57.848213 26771 slave.cpp:285] Agent using credential for: test-principal
I0822 06:26:57.848239 26771 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_jPyB7B/http_credentials'
I0822 06:26:57.848608 26771 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.848762 26771 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.849023 26771 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.849153 26771 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.849407 26771 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.849555 26771 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.851372 26771 slave.cpp:581] 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"}]
I0822 06:26:57.851673 26771 slave.cpp:589] Agent attributes: [ ]
I0822 06:26:57.851689 26771 slave.cpp:598] Agent hostname: d3357831f8b1
I0822 06:26:57.851935 26772 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:26:57.853690 26776 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_g8Kc3i/meta'
I0822 06:26:57.853970 26776 status_update_manager.cpp:203] Recovering status update manager
I0822 06:26:57.854157 26767 containerizer.cpp:609] Recovering containerizer
I0822 06:26:57.855814 26775 provisioner.cpp:416] Provisioner recovery complete
I0822 06:26:57.856273 26772 slave.cpp:6226] Finished recovery
I0822 06:26:57.856751 26772 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:26:57.857029 26773 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:26:57.859524 26767 process.cpp:3933] Handling HTTP event for process 'slave(808)' with path: '/slave(808)/monitor/statistics'
I0822 06:26:57.861673 26771 http.cpp:1166] HTTP GET for /slave(808)/monitor/statistics from 172.17.0.3:57591
I0822 06:26:57.861750 26771 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0822 06:26:57.865931 26776 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (36 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0822 06:26:57.879324 8685 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 06:26:57.879792 8685 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 06:26:57.879911 8685 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 06:26:57.879946 8685 provisioner.cpp:255] Using default backend 'copy'
I0822 06:26:57.881692 8685 cluster.cpp:448] Creating default 'local' authorizer
I0822 06:26:57.883451 26773 slave.cpp:252] Mesos agent started on (809)@172.17.0.3:46296
I0822 06:26:57.883476 26773 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jLVEJQ/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jLVEJQ/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_jLVEJQ/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jLVEJQ/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jLVEJQ/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_jLVEJQ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_jLVEJQ" --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_syOfzx"
I0822 06:26:57.883900 26773 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jLVEJQ/credential'
I0822 06:26:57.884066 26773 slave.cpp:285] Agent using credential for: test-principal
I0822 06:26:57.884100 26773 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_jLVEJQ/http_credentials'
I0822 06:26:57.884412 26773 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.884544 26773 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.884775 26773 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.884901 26773 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.885128 26773 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.885226 26773 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.886593 26773 slave.cpp:581] 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"}]
I0822 06:26:57.886806 26773 slave.cpp:589] Agent attributes: [ ]
I0822 06:26:57.886818 26773 slave.cpp:598] Agent hostname: d3357831f8b1
I0822 06:26:57.886976 26775 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:26:57.888269 26765 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_syOfzx/meta'
I0822 06:26:57.888694 26771 status_update_manager.cpp:203] Recovering status update manager
I0822 06:26:57.888942 26767 containerizer.cpp:609] Recovering containerizer
I0822 06:26:57.890282 26771 provisioner.cpp:416] Provisioner recovery complete
I0822 06:26:57.890703 26774 slave.cpp:6226] Finished recovery
I0822 06:26:57.891208 26774 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:26:57.891435 26776 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:26:57.893399 26769 process.cpp:3933] Handling HTTP event for process 'slave(809)' with path: '/slave(809)/monitor/statistics.json'
I0822 06:26:57.895601 26765 http.cpp:1166] HTTP GET for /slave(809)/monitor/statistics.json from 172.17.0.3:57592
I0822 06:26:57.895689 26765 http.cpp:957] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0822 06:26:57.899436 26763 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (34 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0822 06:26:57.914538 8685 containerizer.cpp:246] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0822 06:26:57.914994 8685 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0822 06:26:57.915098 8685 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0822 06:26:57.915129 8685 provisioner.cpp:255] Using default backend 'copy'
I0822 06:26:57.916828 8685 cluster.cpp:448] Creating default 'local' authorizer
I0822 06:26:57.918712 26766 slave.cpp:252] Mesos agent started on (810)@172.17.0.3:46296
I0822 06:26:57.918737 26766 slave.cpp:253] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_duYbI5/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_duYbI5/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_duYbI5/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_duYbI5/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_duYbI5/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_duYbI5/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.5.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_duYbI5" --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_8gjasM"
I0822 06:26:57.919198 26766 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_duYbI5/credential'
I0822 06:26:57.919339 26766 slave.cpp:285] Agent using credential for: test-principal
I0822 06:26:57.919363 26766 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_duYbI5/http_credentials'
I0822 06:26:57.919693 26766 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.919847 26766 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0822 06:26:57.920042 26766 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.920140 26766 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0822 06:26:57.920336 26766 http.cpp:1026] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.920433 26766 http.cpp:1047] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0822 06:26:57.922232 26766 slave.cpp:581] 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"}]
I0822 06:26:57.922540 26766 slave.cpp:589] Agent attributes: [ ]
I0822 06:26:57.922556 26766 slave.cpp:598] Agent hostname: d3357831f8b1
I0822 06:26:57.922796 26776 status_update_manager.cpp:177] Pausing sending status updates
I0822 06:26:57.924510 26762 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_8gjasM/meta'
I0822 06:26:57.924895 26763 status_update_manager.cpp:203] Recovering status update manager
I0822 06:26:57.925137 26774 containerizer.cpp:609] Recovering containerizer
I0822 06:26:57.926961 26763 provisioner.cpp:416] Provisioner recovery complete
I0822 06:26:57.927407 26767 slave.cpp:6226] Finished recovery
I0822 06:26:57.927963 26767 slave.cpp:6408] Querying resource estimator for oversubscribable resources
I0822 06:26:57.928263 26764 slave.cpp:6422] Received oversubscribable resources {} from the resource estimator
I0822 06:26:57.931120 26766 process.cpp:3933] Handling HTTP event for process 'slave(810)' with path: '/slave(810)/containers'
I0822 06:26:57.933413 26771 http.cpp:1166] HTTP GET for /slave(810)/containers from 172.17.0.3:57593
I0822 06:26:57.933499 26771 http.cpp:957] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0822 06:26:57.938459 8685 slave.cpp:859] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (38 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (334 ms total)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/0 (11 ms)
[ RUN ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1
[ OK ] ContainerizerType/DefaultContainerDNSFlagTest.ValidateFlag/1 (9 ms)
[----------] 2 tests from ContainerizerType/DefaultContainerDNSFlagTest (20 ms total)
[----------] Global test environment tear-down
[==========] 1660 tests from 183 test cases ran. (653207 ms total)
[ PASSED ] 1659 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ExamplesTest.PersistentVolumeFramework
1 FAILED TEST
YOU HAVE 20 DISABLED TESTS
I0822 06:26:58.026197 26778 process.cpp:1072] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.5.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.5.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1503379923-7330
Untagged: mesos-1503379923-7330:latest
Deleted: sha256:deef5ca91dd64a822ab22d6469bf72ad1246d7409e1c5a6fe095d7e009b7ac16
Deleted: sha256:1262a67bce31359f12f271ab31ad0c2b84af96d2bd2ca6c8f7ed55fa4ef6a156
Deleted: sha256:194bc6c4813e8c475fd2c93ec2aa829a3f0496de76105e792edd245f0e302085
Deleted: sha256:62ca7dd4af389fdf30416ff096061834e3e0d21d287033eccde7d46c3bdaa7f9
Deleted: sha256:ad4239c0fe07da4bc08a898d5156619f414da02289a7e9fb7993da78def1cffb
Deleted: sha256:0edab1bd53aebcbf9f1adad19f00cde890ff06df7fe62b7b26b849299be98a50
Deleted: sha256:06abab8d53b89bf05bb957d7bff5446ee5d8f8a2192a79e9ee94695f23fae1cb
Deleted: sha256:6599b6f4490856b568b163d56b1280778cfbd455e846ee9a921d68689f0f1341
Deleted: sha256:04d9d459c6bf488a812b2b341a800b737d871e0e1d5c8fe431d6fcc877a27b3e
Deleted: sha256:47f04e1b1b2cbdd3e53ae7a022a900229e23d35dbb81143ea6be8a27de2d158c
Deleted: sha256:1a309c4d8078711f65d039f79961b6a2f97e8b36e0465c898f357f1e979288e9
Deleted: sha256:10ed50359c415ac3b4422110ec89a4df698e0cb00722666f656d8b0bac119b90
Deleted: sha256:40a827b9b5871688ebe0945eef7a3d4eca2f3a07c7f674b37bbe788bdea07949
Deleted: sha256:7f0bb1bd83236886566a16290fd4e4efb426b53822001f461dbbd381e6a562d1
Deleted: sha256:0e774fd7656d6ad0b5a2af2eea49547aa5cdc75c6ff35d5987a1738107c8dae7
Deleted: sha256:11916a9aaa8faf024623a43f304351a0998ab5be1cd1094ecafa6187326c1fdf
Deleted: sha256:818e9ed6e1b54314a35ea6463c0eb1d40f5c06aea66918be28532a93d530bd74
Deleted: sha256:2c8b3cc2d088f8ffa319755a41f4ebedd4a1436aead7e4da87f70f50990eed45
Deleted: sha256:a1d21513cb6d3307f7ccabeca390d7be20ece4ad47c0832e4af8b33941933146
Deleted: sha256:c0e156883769da1b1d7a9eee4d8008a836e9efeeab030281feec7da7976c56c1
Deleted: sha256:72b3e2dee3079c3f9f5dc2b4369b891c750307b2ce79c66ff926510ff007dec7
Deleted: sha256:cb309d79a79110d776ac99bd774ed9b2697759285512460349131e96a73045e3
Deleted: sha256:db80964f250f6afc58f0e90d4f151ade582be78bdcc3822cc286ed407bcb91bc
Deleted: sha256:0b311c9339b33437f4cffd8db7c0d94adf7906bb6c7851e93b21cb23c0ef0578
Deleted: sha256:11eb6435d61433e47c5fe7a7890277ec9446c739af95f322762596fe99d8f6a5
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user xujyan@apple.com
Not sending mail to unregistered user gregorywmann@gmail.com