See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3797/display/redirect?page=changes>
Changes: [mpark] Moved the message intercepting logic before agent start in a test. ------------------------------------------ [...truncated 26.11 MB...] I0614 09:33:58.256713 31468 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint I0614 09:33:58.260006 31491 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (28 ms) [ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 I0614 09:33:58.271183 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.271690 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.271796 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.271824 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.275367 31470 slave.cpp:248] Mesos agent started on (757)@172.17.0.2:40839 I0614 09:33:58.275382 31470 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_kZeVxg" I0614 09:33:58.275758 31470 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/credential' I0614 09:33:58.275928 31470 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.275950 31470 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_D5rhMH/http_credentials' I0614 09:33:58.276180 31470 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.276314 31470 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.277379 31470 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.277446 31470 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.277463 31470 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.277611 31469 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.279202 31488 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_kZeVxg/meta' I0614 09:33:58.279510 31486 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.279688 31471 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.281286 31482 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.281647 31473 slave.cpp:6127] Finished recovery I0614 09:33:58.282104 31473 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.282323 31485 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.284226 31476 process.cpp:3778] Handling HTTP event for process 'slave(757)' with path: '/slave(757)/containers' I0614 09:33:58.285394 31469 http.cpp:1115] HTTP GET for /slave(757)/containers from 172.17.0.2:41526 I0614 09:33:58.285478 31469 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint I0614 09:33:58.289619 31478 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (29 ms) [ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 I0614 09:33:58.300371 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.301152 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.301293 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.301326 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.304788 31487 slave.cpp:248] Mesos agent started on (758)@172.17.0.2:40839 I0614 09:33:58.304805 31487 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs/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_xhfqWs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs" --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_4xsID1" I0614 09:33:58.305168 31487 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs/credential' I0614 09:33:58.305291 31487 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.305306 31487 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xhfqWs/http_credentials' I0614 09:33:58.305493 31487 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.305701 31487 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.306829 31487 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.306897 31487 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.306906 31487 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.307047 31484 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.308293 31477 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_4xsID1/meta' I0614 09:33:58.308650 31475 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.308890 31487 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.310434 31482 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.310894 31476 slave.cpp:6127] Finished recovery I0614 09:33:58.311316 31476 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.311779 31473 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.313856 31477 process.cpp:3778] Handling HTTP event for process 'slave(758)' with path: '/slave(758)/monitor/statistics' I0614 09:33:58.315026 31483 http.cpp:1115] HTTP GET for /slave(758)/monitor/statistics from 172.17.0.2:41528 I0614 09:33:58.315105 31483 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint I0614 09:33:58.317471 31482 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (28 ms) [ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 I0614 09:33:58.327972 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.328472 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.328578 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.328616 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.332046 31475 slave.cpp:248] Mesos agent started on (759)@172.17.0.2:40839 I0614 09:33:58.332059 31475 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne/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_aPukne/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne" --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_Buku0M" I0614 09:33:58.332420 31475 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne/credential' I0614 09:33:58.332557 31475 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.332571 31475 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_aPukne/http_credentials' I0614 09:33:58.332774 31475 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.333057 31475 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.334205 31475 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.334273 31475 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.334283 31475 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.334435 31480 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.335572 31473 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_Buku0M/meta' I0614 09:33:58.335953 31487 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.336134 31482 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.337487 31487 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.337851 31479 slave.cpp:6127] Finished recovery I0614 09:33:58.338343 31479 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.338567 31474 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.340399 31480 process.cpp:3778] Handling HTTP event for process 'slave(759)' with path: '/slave(759)/monitor/statistics.json' I0614 09:33:58.341539 31479 http.cpp:1115] HTTP GET for /slave(759)/monitor/statistics.json from 172.17.0.2:41530 I0614 09:33:58.341608 31479 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint I0614 09:33:58.343919 31489 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (26 ms) [ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 I0614 09:33:58.354476 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.354974 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.355077 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.355109 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.358497 31478 slave.cpp:248] Mesos agent started on (760)@172.17.0.2:40839 I0614 09:33:58.358512 31478 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z/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_jCw23Z/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z" --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_1zMgDy" I0614 09:33:58.358901 31478 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z/credential' I0614 09:33:58.359063 31478 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.359078 31478 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_jCw23Z/http_credentials' I0614 09:33:58.359287 31478 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.359458 31478 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.360792 31478 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.360858 31478 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.360868 31478 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.360993 31489 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.362407 31485 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_1zMgDy/meta' I0614 09:33:58.362962 31489 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.363231 31477 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.364660 31490 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.365017 31481 slave.cpp:6127] Finished recovery I0614 09:33:58.365517 31481 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.365942 31476 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.367816 31470 process.cpp:3778] Handling HTTP event for process 'slave(760)' with path: '/slave(760)/containers' I0614 09:33:58.369171 31480 http.cpp:1115] HTTP GET for /slave(760)/containers from 172.17.0.2:41532 I0614 09:33:58.369236 31480 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint I0614 09:33:58.371840 31472 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (28 ms) [ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 I0614 09:33:58.382648 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.383144 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.383244 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.383271 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.385148 31467 cluster.cpp:448] Creating default 'local' authorizer I0614 09:33:58.386725 31479 slave.cpp:248] Mesos agent started on (761)@172.17.0.2:40839 I0614 09:33:58.386739 31479 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L/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_4Jch1L/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L" --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_BCrlwk" I0614 09:33:58.387126 31479 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L/credential' I0614 09:33:58.387275 31479 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.387296 31479 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_4Jch1L/http_credentials' I0614 09:33:58.387529 31479 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.387715 31479 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.388895 31479 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.388957 31479 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.388967 31479 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.389099 31473 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.390657 31474 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_BCrlwk/meta' I0614 09:33:58.391005 31479 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.391317 31490 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.392830 31483 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.393252 31471 slave.cpp:6127] Finished recovery I0614 09:33:58.393735 31471 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.393973 31478 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.395699 31486 process.cpp:3778] Handling HTTP event for process 'slave(761)' with path: '/slave(761)/monitor/statistics' I0614 09:33:58.397001 31478 http.cpp:1115] HTTP GET for /slave(761)/monitor/statistics from 172.17.0.2:41534 I0614 09:33:58.397079 31478 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint I0614 09:33:58.400605 31472 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (29 ms) [ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 I0614 09:33:58.411803 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.412315 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.412412 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.412448 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.414238 31467 cluster.cpp:448] Creating default 'local' authorizer I0614 09:33:58.415755 31472 slave.cpp:248] Mesos agent started on (762)@172.17.0.2:40839 I0614 09:33:58.415769 31472 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy/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_vIBFfy/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy" --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_R78pG6" I0614 09:33:58.416149 31472 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy/credential' I0614 09:33:58.416319 31472 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.416334 31472 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_vIBFfy/http_credentials' I0614 09:33:58.416537 31472 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.416695 31472 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.417956 31472 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.418020 31472 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.418030 31472 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.418153 31486 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.419847 31480 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_R78pG6/meta' I0614 09:33:58.420250 31473 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.420490 31488 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.422019 31475 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.422472 31471 slave.cpp:6127] Finished recovery I0614 09:33:58.422883 31471 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.423245 31486 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.425173 31472 process.cpp:3778] Handling HTTP event for process 'slave(762)' with path: '/slave(762)/monitor/statistics.json' I0614 09:33:58.426499 31484 http.cpp:1115] HTTP GET for /slave(762)/monitor/statistics.json from 172.17.0.2:41536 I0614 09:33:58.426578 31484 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint I0614 09:33:58.432083 31475 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (31 ms) [ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 I0614 09:33:58.443359 31467 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret W0614 09:33:58.443913 31467 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0614 09:33:58.444015 31467 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0614 09:33:58.444046 31467 provisioner.cpp:255] Using default backend 'copy' I0614 09:33:58.445868 31467 cluster.cpp:448] Creating default 'local' authorizer I0614 09:33:58.447376 31474 slave.cpp:248] Mesos agent started on (763)@172.17.0.2:40839 I0614 09:33:58.447389 31474 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk/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_F8mzMk/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk" --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_L0gB8S" I0614 09:33:58.447723 31474 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk/credential' I0614 09:33:58.447871 31474 slave.cpp:281] Agent using credential for: test-principal I0614 09:33:58.447885 31474 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_F8mzMk/http_credentials' I0614 09:33:58.448079 31474 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0614 09:33:58.448236 31474 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0614 09:33:58.449584 31474 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0614 09:33:58.449648 31474 slave.cpp:560] Agent attributes: [ ] I0614 09:33:58.449656 31474 slave.cpp:565] Agent hostname: cacd5eb0a4a1 I0614 09:33:58.449785 31482 status_update_manager.cpp:177] Pausing sending status updates I0614 09:33:58.451292 31469 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_L0gB8S/meta' I0614 09:33:58.451706 31472 status_update_manager.cpp:203] Recovering status update manager I0614 09:33:58.451905 31473 containerizer.cpp:582] Recovering containerizer I0614 09:33:58.453428 31472 provisioner.cpp:416] Provisioner recovery complete I0614 09:33:58.453908 31477 slave.cpp:6127] Finished recovery I0614 09:33:58.454427 31477 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0614 09:33:58.454804 31485 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0614 09:33:58.457129 31488 process.cpp:3778] Handling HTTP event for process 'slave(763)' with path: '/slave(763)/containers' I0614 09:33:58.458312 31472 http.cpp:1115] HTTP GET for /slave(763)/containers from 172.17.0.2:41538 I0614 09:33:58.458395 31472 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint I0614 09:33:58.462611 31479 slave.cpp:817] Agent terminating [ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (31 ms) [----------] 9 tests from Endpoint/SlaveEndpointTest (263 ms total) [----------] Global test environment tear-down [==========] 1546 tests from 169 test cases ran. (298810 ms total) [ PASSED ] 1545 tests. [ FAILED ] 1 test, listed below: [ FAILED ] PersistentVolumeEndpointsTest.ReserveAndSlaveRemoval 1 FAILED TEST YOU HAVE 19 DISABLED TESTS E0614 09:33:58.524660 31492 process.cpp:968] Failed to accept socket: future discarded make[3]: *** [CMakeFiles/check] Error 1 make[3]: Leaving directory `/mesos/build' make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[2]: Leaving directory `/mesos/build' make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make[1]: Leaving directory `/mesos/build' make: *** [check] Error 2 + docker rmi mesos-1497430314-16234 Untagged: mesos-1497430314-16234:latest Deleted: sha256:ce1d00d354e92668b5c7634abbad3917b415ad23b60f76fe045639c2f6fc7a82 Deleted: sha256:a94de1f7c473ea8903ec86cf14f4bc4e52adfe9428d3a57eb440a910209e21e3 Deleted: sha256:59d5e1a9ffb45d121b57af8cac87bb47e6f9eb16b66041ecf24f735910a2b20c Deleted: sha256:273c957fbd23c848f5bd5f3c07621403be1fb5238992722d8625c17e07ace9b5 Deleted: sha256:a366d7d27eb6dac59908b569bdff1af167b8476953cb3169b3de2f6f9c3393fc Deleted: sha256:a2b98ce01fe0ee75cf12fe703bfe5f13c06c20c390c560522950c756ae58a6bc Deleted: sha256:c58b1f5999a4631bbc8ca2c8cc723bb43df7e8856498e1834690e1d37cbedc8d Deleted: sha256:c9456ea40258b5dd3e4eb9b81101eb6ec661e32dde25bc1cd31de0fabde6987f Deleted: sha256:8106bbddaf2149d7dd253589269f268d08ad2cbb337b6903463c1991d6ca4983 Deleted: sha256:cd62ce1ee5c5ad5ac230aa7754ec36a2700309d4fa019b2e96a6299ff0073b39 Deleted: sha256:17b9ab8316903e3fc374a375f9b007c5be2920b17c59a8daadc6b4687e4c6a92 Deleted: sha256:458dba72da44101c61177c8f6e35f4615114ee4a4325f43b22553576e9089a8e Deleted: sha256:68df8c0ef7598dc2840c47f4df8390cf768ee3d76807dc26714b986bfbde5fc0 Deleted: sha256:f035012b5beadc8463fbe24d70e9a8d15dbcc548c417640b8caab3d3679e6274 Deleted: sha256:15bc6678bfe266475b7dcc82da5e8aa69c09cf62f7e9013c56ce4588d4bb68c8 Deleted: sha256:a9f1052b1e408b18f2f8f1ed8888c831bf50c2dafb056617304fdc74b23141cd Deleted: sha256:a2d23acaddfaa0df984a7ef4811b95fc2d685c7b1ffb6e6745bc1548f3547e98 Deleted: sha256:c448d382be8ec783a9605fad114ef29f66417556a1e5ce37377c7228d6bf1d47 Deleted: sha256:8ddeacacbe7cd720e5240585b939f0e6457588a9225be5f7159df3602216426f Deleted: sha256:04f6031c7ead0386c43cf8f16b09985ee51b361cadf0021b412db9242a4c58e6 Deleted: sha256:c532a6f2827c150744cb78219044bb3edf2af8c128a5a58d9db8ac931a77e2f0 Deleted: sha256:049e107363e0325ed99b6186fdf4303262ee2132205dfad8e7068e44a3d852dc Deleted: sha256:f2a2f34c69ec3fa39d150c661cf05c0809011de9f0db653c294ade0c9327cd0f Deleted: sha256:216bdc4cb38cc3a86a1d3863c9e219b5be11d9963cb9bf4e170e9294ec2e824f Deleted: sha256:e6970cff8905e01e7d197c6ba75fdb87188094319af3f547b92d987553cebb03 Build step 'Execute shell' marked build as failure
