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 2016/10/28 18:47:45 UTC

Build failed in Jenkins: Mesos » autotools,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2842

See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2842/changes>

Changes:

[toenshoff] Fixed incorrect check in dynamic_cast.

------------------------------------------
[...truncated 199585 lines...]
W1028 18:47:20.139205 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.139876 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.146081 26707 slave.cpp:198] Agent started on 554)@172.17.0.3:55828
I1028 18:47:20.146152 26707 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9rW74X/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9rW74X/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9rW74X/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_9rW74X"
I1028 18:47:20.146879 26707 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9rW74X/credential'
I1028 18:47:20.147110 26707 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.147136 26707 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9rW74X/http_credentials'
I1028 18:47:20.147460 26707 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.147639 26707 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.147933 26707 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.148386 26707 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.148906 26707 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.149000 26707 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.149024 26707 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.151088 26708 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9rW74X/meta'
I1028 18:47:20.151368 26711 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.151423 26713 process.cpp:3364] Handling HTTP event for process 'slave(554)' with path: '/slave(554)/containers'
I1028 18:47:20.151880 26713 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.152604 26710 http.cpp:835] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 18:47:20.153800 26716 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.154161 26716 slave.cpp:4810] Finished recovery
I1028 18:47:20.154875 26716 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.155156 26705 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.167181 26686 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (42 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I1028 18:47:20.182530 26686 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 18:47:20.184640 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.184888 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.209440 26705 slave.cpp:198] Agent started on 555)@172.17.0.3:55828
I1028 18:47:20.209509 26705 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WtGVxq/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WtGVxq/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WtGVxq/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_WtGVxq"
I1028 18:47:20.210224 26705 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WtGVxq/credential'
I1028 18:47:20.210454 26705 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.210484 26705 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WtGVxq/http_credentials'
I1028 18:47:20.210775 26705 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.210954 26705 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.211248 26705 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.211714 26705 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.212231 26705 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.212319 26705 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.212338 26705 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.214334 26715 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WtGVxq/meta'
I1028 18:47:20.215068 26715 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.215240 26715 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.216253 26714 process.cpp:3364] Handling HTTP event for process 'slave(555)' with path: '/slave(555)/monitor/statistics'
I1028 18:47:20.217558 26714 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.217741 26710 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 18:47:20.218263 26710 slave.cpp:4810] Finished recovery
I1028 18:47:20.218935 26710 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.223474 26716 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.239558 26686 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (82 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I1028 18:47:20.262722 26686 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 18:47:20.263859 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.264086 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.274158 26715 slave.cpp:198] Agent started on 556)@172.17.0.3:55828
I1028 18:47:20.274222 26715 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_v2rTBT/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_v2rTBT/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_v2rTBT/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_v2rTBT"
I1028 18:47:20.275012 26715 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_v2rTBT/credential'
I1028 18:47:20.275275 26715 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.275300 26715 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_v2rTBT/http_credentials'
I1028 18:47:20.275593 26715 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.275796 26715 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.276088 26715 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.276582 26715 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.277179 26715 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.277269 26715 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.277285 26715 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.279449 26715 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_v2rTBT/meta'
I1028 18:47:20.279850 26719 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.280061 26719 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.281905 26710 process.cpp:3364] Handling HTTP event for process 'slave(556)' with path: '/slave(556)/monitor/statistics.json'
I1028 18:47:20.281963 26711 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.282536 26710 slave.cpp:4810] Finished recovery
I1028 18:47:20.283123 26710 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.283546 26710 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.284867 26713 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 18:47:20.313594 26686 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (61 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I1028 18:47:20.325162 26686 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 18:47:20.326263 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.326458 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.331382 26707 slave.cpp:198] Agent started on 557)@172.17.0.3:55828
I1028 18:47:20.331473 26707 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Eevan/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Eevan/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Eevan/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_3Eevan"
I1028 18:47:20.332218 26707 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Eevan/credential'
I1028 18:47:20.332487 26707 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.332518 26707 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Eevan/http_credentials'
I1028 18:47:20.332787 26707 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.332988 26707 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.333250 26707 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.333660 26707 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.334157 26707 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.334236 26707 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.334254 26707 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.336030 26707 process.cpp:3364] Handling HTTP event for process 'slave(557)' with path: '/slave(557)/containers'
I1028 18:47:20.336498 26707 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_3Eevan/meta'
I1028 18:47:20.337530 26707 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.337941 26707 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.338452 26707 http.cpp:835] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 18:47:20.340121 26716 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.340553 26716 slave.cpp:4810] Finished recovery
I1028 18:47:20.341121 26716 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.341442 26716 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.359683 26686 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (60 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I1028 18:47:20.385814 26686 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 18:47:20.387259 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.387732 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.390136 26686 cluster.cpp:434] Creating default 'local' authorizer
I1028 18:47:20.393710 26718 slave.cpp:198] Agent started on 558)@172.17.0.3:55828
I1028 18:47:20.393786 26718 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Nv79bR/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Nv79bR/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Nv79bR/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_Nv79bR"
I1028 18:47:20.394474 26718 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Nv79bR/credential'
I1028 18:47:20.394721 26718 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.394749 26718 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Nv79bR/http_credentials'
I1028 18:47:20.395052 26718 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.395249 26718 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.395576 26718 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.396275 26718 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.397135 26718 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.397411 26718 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.397562 26718 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.400192 26718 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Nv79bR/meta'
I1028 18:47:20.400866 26719 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.401171 26719 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.403374 26717 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.403962 26717 slave.cpp:4810] Finished recovery
I1028 18:47:20.404557 26717 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.405494 26717 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.406781 26715 process.cpp:3364] Handling HTTP event for process 'slave(558)' with path: '/slave(558)/monitor/statistics'
I1028 18:47:20.408546 26715 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 18:47:20.432063 26708 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (58 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I1028 18:47:20.445503 26686 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 18:47:20.447015 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.447384 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.449630 26686 cluster.cpp:434] Creating default 'local' authorizer
I1028 18:47:20.452494 26714 slave.cpp:198] Agent started on 559)@172.17.0.3:55828
I1028 18:47:20.452577 26714 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wzv9Gl/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wzv9Gl/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wzv9Gl/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_wzv9Gl"
I1028 18:47:20.453311 26714 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wzv9Gl/credential'
I1028 18:47:20.453550 26714 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.453575 26714 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wzv9Gl/http_credentials'
I1028 18:47:20.453840 26714 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.454031 26714 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.454264 26714 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.454671 26714 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.455160 26714 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.455238 26714 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.455256 26714 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.458421 26714 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_wzv9Gl/meta'
I1028 18:47:20.459203 26714 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.459488 26719 process.cpp:3364] Handling HTTP event for process 'slave(559)' with path: '/slave(559)/monitor/statistics.json'
I1028 18:47:20.459874 26713 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.460880 26714 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 18:47:20.461524 26713 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.462800 26714 slave.cpp:4810] Finished recovery
I1028 18:47:20.463598 26714 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.464133 26714 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.495872 26686 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (70 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I1028 18:47:20.513916 26686 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 18:47:20.515066 26686 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 18:47:20.515303 26686 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 18:47:20.517323 26686 cluster.cpp:434] Creating default 'local' authorizer
I1028 18:47:20.521108 26704 slave.cpp:198] Agent started on 560)@172.17.0.3:55828
I1028 18:47:20.521180 26704 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OYgfIQ/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OYgfIQ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OYgfIQ/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.2/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_OYgfIQ"
I1028 18:47:20.521817 26704 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OYgfIQ/credential'
I1028 18:47:20.522048 26704 slave.cpp:336] Agent using credential for: test-principal
I1028 18:47:20.522074 26704 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OYgfIQ/http_credentials'
I1028 18:47:20.522342 26704 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 18:47:20.522500 26704 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 18:47:20.522778 26704 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.523285 26704 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1028 18:47:20.523867 26704 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 18:47:20.523960 26704 slave.cpp:527] Agent attributes: [  ]
I1028 18:47:20.523984 26704 slave.cpp:532] Agent hostname: 2e3dc9cf6a8f
I1028 18:47:20.526444 26704 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OYgfIQ/meta'
I1028 18:47:20.526975 26704 status_update_manager.cpp:200] Recovering status update manager
I1028 18:47:20.527148 26704 containerizer.cpp:522] Recovering containerizer
I1028 18:47:20.529029 26706 provisioner.cpp:253] Provisioner recovery complete
I1028 18:47:20.531532 26710 slave.cpp:4810] Finished recovery
I1028 18:47:20.532305 26710 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 18:47:20.532465 26710 process.cpp:3364] Handling HTTP event for process 'slave(560)' with path: '/slave(560)/containers'
I1028 18:47:20.533205 26710 slave.cpp:4996] Received oversubscribable resources  from the resource estimator
I1028 18:47:20.534050 26704 http.cpp:835] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 18:47:20.555649 26686 slave.cpp:767] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (53 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (543 ms total)

[----------] Global test environment tear-down
[==========] 1242 tests from 140 test cases ran. (557259 ms total)
[  PASSED  ] 1241 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ContentType/MasterAPITest.Subscribe/1, where GetParam() = application/json

 1 FAILED TEST
  YOU HAVE 6 DISABLED TESTS

make[4]: Leaving directory `/mesos/mesos-1.0.2/_build/src'
make[4]: *** [check-local] Error 1
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.0.2/_build/src'
make[2]: Leaving directory `/mesos/mesos-1.0.2/_build/src'
make[2]: *** [check] Error 2
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.0.2/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1477678341-15040
Untagged: mesos-1477678341-15040:latest
Deleted: sha256:143c3f0c79f4e54edfdd8bef8c6a61dffca9365e2c5ba6ec37be9cff67f0099c
Deleted: sha256:edd1b4d56755440dcc8010e37fb077c3b243e14dd580f3720704d60ec582f5ee
Deleted: sha256:94adf5457fe8ead64c49f0e499f7c87def55c33ec627419a8922272e976040a7
Deleted: sha256:52b5a9bc27bbed37412992f1979159e0027030a6802cf20dedb86c72a80ea42e
Deleted: sha256:1aac1d064b99863bceab6da0baf0a29fa0db02a28994988df937586749974c80
Deleted: sha256:4321e48ef4cec248e79fb1e7f1ef06fefd305787b04173092c2bbb1f6c92340b
Deleted: sha256:edf058608ae224b9163c730a37a53cbde828ca340689b2dbc8ab2942b9e53280
Deleted: sha256:1a04ef71318a301f77ba45251732b27708591345bbe56c263a97d59f48d7fdf5
Deleted: sha256:02884dc4b7d39e10c44a36d812ef1a7fd5535298c54f84fedc4d99bb45a3d050
Deleted: sha256:6bad581b1069fad9ecd4b7d577d052a163f34c60a9e73c6e4c4132074c4bc85f
Deleted: sha256:ba91dec6e935e09405742a68eb812ca84d40f68910f215842aa4ee02a0951f27
Deleted: sha256:3cf21adf72f285789fa9ddfdd31ceb050eae6740f349d6ca0ef5cb5af8c3e80e
Deleted: sha256:4261d98494efafd6bfb798992c852949b07d31a24a1ee7211eb01df72fceedb8
Deleted: sha256:4eaaa728c48ab3e2fffb0d4c35721a62abc5d7e79723d02e4eaff3736c07516b
Deleted: sha256:9679dc87cde866473ad900eb8764334a91653be416e8849599cdb7d3140788ea
Deleted: sha256:19fb320ddf7b6a6e3b7ec39fd346cc3fd0dc994ea9486bdc95bce956dee2f34e
Deleted: sha256:01924d212f621488415afd853d89b9d31afc4f394051e7bc349991fe7e2093cb
Deleted: sha256:a974753e8c9d970242c1d3fc8590c8b4912152205044d85a639dd298713f1650
Deleted: sha256:2cdea02e0de307bd3eed64ed60409e538ced3dd69a39eefca48e4b0dc0deeace
Deleted: sha256:1b1f6eb2b6c51bc21e5c32d6bbb899f7518a044e7753d7a00d627ab2b4db94b7
Deleted: sha256:0a1c60edaaad14cadf913684817d67936b650101607d2863a0917102c90c5950
Deleted: sha256:b45be81064c1bc2cfba94e355eabcc84020756d27cb6557af09363747a31baa6
Build step 'Execute shell' marked build as failure

Jenkins build is back to normal : Mesos » autotools,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2847

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2847/changes>


Build failed in Jenkins: Mesos » autotools,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2846

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2846/changes>

Changes:

[toenshoff] Added MESOS-6497 to CHANGELOG.

[joris.van.remoortere] Fixed MesosNativeLibrary to use '_NUM' MESOS_VERSION macros.

[joris.van.remoortere] Added MESOS-6502 to CHANGLOG for 1.1.0.

[vinodkone] Fixed duplicate framework ids in "unregistered_frameworks".

[vinodkone] Added MESOS-4973 and MESOS-6461 to 1.1.0 CHANGELOG.

------------------------------------------
[...truncated 210874 lines...]
I1028 22:44:13.312571 27699 scheduler.cpp:387] Ignoring disconnection attempt from stale connection
I1028 22:44:13.315152 27700 scheduler.cpp:353] Connected with the master at http://172.17.0.2:49655/master/api/v1/scheduler
I1028 22:44:13.316561 27698 scheduler.cpp:440] Lost leading master
I1028 22:44:13.317054 27698 scheduler.cpp:387] Ignoring disconnection attempt from stale connection
I1028 22:44:13.317107 27698 scheduler.cpp:387] Ignoring disconnection attempt from stale connection
I1028 22:44:13.317730 27689 scheduler.cpp:287] Ignoring reconnect request from scheduler since we are disconnected
I1028 22:44:13.318634 27690 master.cpp:1097] Master terminating
I1028 22:44:13.332180 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.332885 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.333065 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.336355 27692 slave.cpp:208] Mesos agent started on (620)@172.17.0.2:49655
I1028 22:44:13.336475 27692 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_XA7zBT/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_XA7zBT/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_XA7zBT/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_XA7zBT" --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_0_MiRbPP"
I1028 22:44:13.337101 27692 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_XA7zBT/credential'
I1028 22:44:13.337278 27692 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.337312 27692 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_XA7zBT/http_credentials'
I1028 22:44:13.337579 27692 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.337733 27692 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.339217 27692 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.339360 27692 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.339377 27692 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.340936 27687 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_0_MiRbPP/meta'
I1028 22:44:13.341027 27692 process.cpp:3377] Handling HTTP event for process 'slave(620)' with path: '/slave(620)/monitor/statistics'
I1028 22:44:13.341549 27689 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.341900 27691 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.342028 27695 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 22:44:13.343591 27693 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.343858 27694 slave.cpp:5281] Finished recovery
I1028 22:44:13.344478 27694 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.344763 27697 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.346621 27687 slave.cpp:787] Agent terminating
I1028 22:44:13.357272 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.357916 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.358083 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.361058 27691 slave.cpp:208] Mesos agent started on (621)@172.17.0.2:49655
I1028 22:44:13.361104 27691 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_tUFvX8/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_tUFvX8/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_tUFvX8/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_tUFvX8" --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_1_UOp164"
I1028 22:44:13.361733 27691 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_tUFvX8/credential'
I1028 22:44:13.361891 27691 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.361917 27691 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_tUFvX8/http_credentials'
I1028 22:44:13.362174 27691 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.362332 27691 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.363649 27691 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.363745 27691 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.363761 27691 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.365344 27692 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_UOp164/meta'
I1028 22:44:13.365414 27691 process.cpp:3377] Handling HTTP event for process 'slave(621)' with path: '/slave(621)/monitor/statistics.json'
I1028 22:44:13.365917 27692 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.366199 27699 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.366556 27688 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 22:44:13.367727 27702 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.368639 27688 slave.cpp:5281] Finished recovery
I1028 22:44:13.369240 27688 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.369436 27700 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.370777 27688 slave.cpp:787] Agent terminating
I1028 22:44:13.381094 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.381764 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.381948 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.384903 27692 slave.cpp:208] Mesos agent started on (622)@172.17.0.2:49655
I1028 22:44:13.384946 27692 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xTd2yo/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xTd2yo/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xTd2yo/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xTd2yo" --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_8vtGEk"
I1028 22:44:13.385407 27692 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xTd2yo/credential'
I1028 22:44:13.385596 27692 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.385620 27692 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_xTd2yo/http_credentials'
I1028 22:44:13.385886 27692 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.386037 27692 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.387456 27692 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.387553 27692 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.387567 27692 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.389111 27698 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_8vtGEk/meta'
I1028 22:44:13.389197 27692 process.cpp:3377] Handling HTTP event for process 'slave(622)' with path: '/slave(622)/containers'
I1028 22:44:13.389634 27693 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.389940 27699 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.390046 27697 http.cpp:839] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 22:44:13.391700 27693 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.392000 27702 slave.cpp:5281] Finished recovery
I1028 22:44:13.392439 27702 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.392762 27697 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.393388 27699 slave.cpp:787] Agent terminating
I1028 22:44:13.403730 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.404227 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.404358 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.406988 27696 slave.cpp:208] Mesos agent started on (623)@172.17.0.2:49655
I1028 22:44:13.407034 27696 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hEHrpE/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hEHrpE/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hEHrpE/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hEHrpE" --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_anHorA"
I1028 22:44:13.407776 27696 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hEHrpE/credential'
I1028 22:44:13.407945 27696 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.407976 27696 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hEHrpE/http_credentials'
I1028 22:44:13.408248 27696 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.408608 27696 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.410039 27696 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.410116 27696 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.410130 27696 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.411458 27701 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_anHorA/meta'
I1028 22:44:13.411525 27696 process.cpp:3377] Handling HTTP event for process 'slave(623)' with path: '/slave(623)/monitor/statistics'
I1028 22:44:13.411936 27689 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.412186 27696 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.412313 27693 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 22:44:13.413511 27700 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.413732 27688 slave.cpp:5281] Finished recovery
I1028 22:44:13.414155 27688 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.414419 27688 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.414667 27689 slave.cpp:787] Agent terminating
I1028 22:44:13.425380 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.426112 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.426337 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.429774 27693 slave.cpp:208] Mesos agent started on (624)@172.17.0.2:49655
I1028 22:44:13.429862 27693 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NLgOtU/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NLgOtU/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NLgOtU/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NLgOtU" --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_SGZgsQ"
I1028 22:44:13.430457 27693 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NLgOtU/credential'
I1028 22:44:13.430624 27693 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.430656 27693 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_NLgOtU/http_credentials'
I1028 22:44:13.430970 27693 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.431128 27693 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.432296 27693 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.432379 27693 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.432395 27693 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.433740 27700 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_SGZgsQ/meta'
I1028 22:44:13.433830 27693 process.cpp:3377] Handling HTTP event for process 'slave(624)' with path: '/slave(624)/monitor/statistics.json'
I1028 22:44:13.434350 27701 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.434507 27693 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.434824 27690 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 22:44:13.435863 27692 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.436275 27694 slave.cpp:5281] Finished recovery
I1028 22:44:13.436766 27694 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.436933 27688 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.437584 27690 slave.cpp:787] Agent terminating
I1028 22:44:13.447731 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.448400 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.448566 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.451874 27698 slave.cpp:208] Mesos agent started on (625)@172.17.0.2:49655
I1028 22:44:13.451917 27698 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_JYUMMa/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_JYUMMa/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_JYUMMa/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_JYUMMa" --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_Cr6BH6"
I1028 22:44:13.452471 27698 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_JYUMMa/credential'
I1028 22:44:13.452658 27698 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.452687 27698 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_JYUMMa/http_credentials'
I1028 22:44:13.452939 27698 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.453161 27698 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.454452 27698 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.454545 27698 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.454562 27698 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.456136 27692 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Cr6BH6/meta'
I1028 22:44:13.456229 27698 process.cpp:3377] Handling HTTP event for process 'slave(625)' with path: '/slave(625)/containers'
I1028 22:44:13.456756 27699 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.457044 27690 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.457188 27702 http.cpp:839] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 22:44:13.458297 27699 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.458611 27700 slave.cpp:5281] Finished recovery
I1028 22:44:13.459142 27700 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.459422 27700 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.460165 27698 slave.cpp:787] Agent terminating
I1028 22:44:13.470051 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.470628 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.470785 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.472113 27669 cluster.cpp:435] Creating default 'local' authorizer
I1028 22:44:13.473824 27687 slave.cpp:208] Mesos agent started on (626)@172.17.0.2:49655
I1028 22:44:13.473865 27687 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LKWjkr/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LKWjkr/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LKWjkr/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LKWjkr" --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_Qivvbn"
I1028 22:44:13.474344 27687 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LKWjkr/credential'
I1028 22:44:13.474519 27687 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.474547 27687 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LKWjkr/http_credentials'
I1028 22:44:13.474812 27687 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.474990 27687 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.476245 27687 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.476346 27687 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.476372 27687 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.478086 27688 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Qivvbn/meta'
I1028 22:44:13.478163 27687 process.cpp:3377] Handling HTTP event for process 'slave(626)' with path: '/slave(626)/monitor/statistics'
I1028 22:44:13.478546 27689 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.478868 27698 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.478946 27693 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 22:44:13.480386 27687 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.480885 27693 slave.cpp:5281] Finished recovery
I1028 22:44:13.481343 27693 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.481515 27692 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.482713 27695 slave.cpp:787] Agent terminating
I1028 22:44:13.492771 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.493430 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.493607 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.495093 27669 cluster.cpp:435] Creating default 'local' authorizer
I1028 22:44:13.497047 27693 slave.cpp:208] Mesos agent started on (627)@172.17.0.2:49655
I1028 22:44:13.497095 27693 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_pBwl6H/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_pBwl6H/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_pBwl6H/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_pBwl6H" --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_iadUTD"
I1028 22:44:13.497689 27693 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_pBwl6H/credential'
I1028 22:44:13.497882 27693 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.497920 27693 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_pBwl6H/http_credentials'
I1028 22:44:13.498311 27693 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.498494 27693 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.500039 27693 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.500135 27693 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.500151 27693 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.501518 27697 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_iadUTD/meta'
I1028 22:44:13.501621 27693 process.cpp:3377] Handling HTTP event for process 'slave(627)' with path: '/slave(627)/monitor/statistics.json'
I1028 22:44:13.502091 27695 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.502279 27692 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.502571 27693 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 22:44:13.503728 27699 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.504256 27698 slave.cpp:5281] Finished recovery
I1028 22:44:13.504729 27698 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.504904 27698 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.506043 27696 slave.cpp:787] Agent terminating
I1028 22:44:13.515965 27669 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 22:44:13.516609 27669 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 22:44:13.516777 27669 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 22:44:13.518201 27669 cluster.cpp:435] Creating default 'local' authorizer
I1028 22:44:13.519958 27687 slave.cpp:208] Mesos agent started on (628)@172.17.0.2:49655
I1028 22:44:13.520002 27687 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OkXz7Y/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OkXz7Y/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OkXz7Y/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OkXz7Y" --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_H16kRU"
I1028 22:44:13.520498 27687 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OkXz7Y/credential'
I1028 22:44:13.520665 27687 slave.cpp:346] Agent using credential for: test-principal
I1028 22:44:13.520697 27687 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_OkXz7Y/http_credentials'
I1028 22:44:13.520998 27687 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 22:44:13.521147 27687 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 22:44:13.522281 27687 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 22:44:13.522370 27687 slave.cpp:541] Agent attributes: [  ]
I1028 22:44:13.522385 27687 slave.cpp:546] Agent hostname: a6377ae42ea4
I1028 22:44:13.523665 27702 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_H16kRU/meta'
I1028 22:44:13.523720 27687 process.cpp:3377] Handling HTTP event for process 'slave(628)' with path: '/slave(628)/containers'
I1028 22:44:13.524211 27697 status_update_manager.cpp:203] Recovering status update manager
I1028 22:44:13.524546 27693 containerizer.cpp:555] Recovering containerizer
I1028 22:44:13.524613 27696 http.cpp:839] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 22:44:13.525599 27690 provisioner.cpp:253] Provisioner recovery complete
I1028 22:44:13.526010 27692 slave.cpp:5281] Finished recovery
I1028 22:44:13.526444 27692 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 22:44:13.526636 27689 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 22:44:13.528271 27694 slave.cpp:787] Agent terminating
make[4]: *** [check-local] Error 1
make[3]: *** [check-am] Error 2
make[2]: *** [check] Error 2
make[1]: *** [check-recursive] Error 1
make: *** [distcheck] Error 1
+ docker rmi mesos-1477692388-29568
Untagged: mesos-1477692388-29568:latest
Deleted: sha256:88158d32c2abc885a18792b99d0aaa699b26c68389f80be464cc9dd2fd5b9841
Deleted: sha256:80baebc58fcf880e87256daa4f0661e54e8e79865a0fbecd0487f7eb7f6001cd
Deleted: sha256:2ecdd933008e76299cc59baeff69056ee3b865b7f1198f724ef5bbe23bcb9887
Deleted: sha256:596d128bfef5795db3d4db22d10ce81270a0c3bd4f9e93e6126e51fbf8290915
Deleted: sha256:c6fc4164d7ee857e6d013738618e21505d39dd3557874e72ea1a993b8b267cad
Deleted: sha256:c5d0901ce5f33e408ed26b64ecfb974777ac9aa3da5b5de6abbb4b1d837969ba
Deleted: sha256:ce8b80c2fb0b2b620d360b28e85ba51c0af51a7a7ecf0901a137d2d4c8d5a931
Deleted: sha256:c7642bf8ca4f2bb61917de5c48594a7e0830baeb985c29c407418702996b17e9
Deleted: sha256:1c32aca5fc4f4c6a126cf51d65e3b6b74aa2adfd1f26b30c57e849259445b250
Deleted: sha256:4e20bac0f790e678e0045a133e0234dcb486dc0fd3286856d5b7cfe53b34c473
Deleted: sha256:95a7500fee9f947c7ebb0448503cab7acd5c17e3b7257356ccf651a76cd8667b
Deleted: sha256:af26491568d314b587aa009c90838aa19738c0f5240b609c749afde6bc3ad8e7
Deleted: sha256:176c517ed3e74ea7fa5760696d791336b21931d464191c22ab589ce834731c1c
Deleted: sha256:c55b3660b3b2d472e00bf341c44ab5f65a853f9bd264fabcc858fdf395843677
Deleted: sha256:ca23aedb8222ea2d3ef468aa84b89ca5894511afba7c1adcdbd416a847860804
Deleted: sha256:e61d482ad14c641b58463e9316862ce8a96b0483b95f5eddf7667df6ec3dbb09
Deleted: sha256:68af7d01f8e5b12cd7bc4f3ada8e24b76fba6d17563f759f3150f831c64d189c
Deleted: sha256:38f1cb2c92cf1d11f9e6996c895b57f60a580e4453d7232158ce56231a0645f0
Deleted: sha256:08273960010c1f6e5e70f5e0a159dabbf48c35eeebed95fdaf99e25b8d1964b4
Deleted: sha256:9e71448dc20dbab96fe9634ac260d1c5bcab694f16434c6c75431c648d16ad6d
Deleted: sha256:c6a765954fa9acec34762217e05b1e625957b821ffdce81e7d9b154630e89b92
Deleted: sha256:491f13b661429fc1bf43df9158db1aee3aeb17eb877bdabf709a87ba2c7a063b
Deleted: sha256:91fd9b1ace77a2f0e7acf52a84f6480714b352d736fd281d912ef7a952cfa226
Deleted: sha256:727b341d8b543ea4b83f75ed44e175de4a0276c196872fa2fdda24344f4a4e10
Build step 'Execute shell' marked build as failure

Build failed in Jenkins: Mesos » autotools,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2845

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2845/changes>

Changes:

[xujyan] Fixed master that leaks empty entries in its hashmaps.

[xujyan] Added MESOS-4975 to CHANGELOG for 1.0.2.

[vinodkone] Fixed duplicate framework ids in "unregistered_frameworks".

[vinodkone] Added MESOS-4973 and MESOS-6461 to 1.0.2 CHANGELOG.

------------------------------------------
[...truncated 118514 lines...]
I1028 21:39:22.598239 26706 resources.cpp:572] Parsing resources as JSON failed: cpus:8;mem:4096
Trying semicolon-delimited string format instead
I1028 21:39:22.598639 26706 slave.cpp:519] Agent resources: cpus(*):8; mem(*):4096; disk(*):3.70122e+06; ports(*):[31000-32000]
I1028 21:39:22.598723 26706 slave.cpp:527] Agent attributes: [  ]
I1028 21:39:22.598734 26706 slave.cpp:532] Agent hostname: 885c22ee76ba
I1028 21:39:22.599190 26693 sched.cpp:330] New master detected at master@172.17.0.3:58880
I1028 21:39:22.599299 26693 sched.cpp:396] Authenticating with master master@172.17.0.3:58880
I1028 21:39:22.599323 26693 sched.cpp:403] Using default CRAM-MD5 authenticatee
I1028 21:39:22.599436 26705 hierarchical.cpp:1535] No allocations performed
I1028 21:39:22.599504 26705 hierarchical.cpp:1170] Performed allocation for 0 agents in 128728ns
I1028 21:39:22.599540 26707 authenticatee.cpp:121] Creating new client SASL connection
I1028 21:39:22.599815 26704 master.cpp:5909] Authenticating scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:22.599959 26694 authenticator.cpp:414] Starting authentication session for crammd5_authenticatee(648)@172.17.0.3:58880
I1028 21:39:22.600267 26705 authenticator.cpp:98] Creating new server SASL connection
I1028 21:39:22.600469 26700 state.cpp:57] Recovering state from '/tmp/ReservationTest_IncompatibleCheckpointedResources_MxUf7z/meta'
I1028 21:39:22.600625 26706 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1028 21:39:22.600658 26706 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1028 21:39:22.600741 26703 status_update_manager.cpp:200] Recovering status update manager
I1028 21:39:22.600903 26708 authenticator.cpp:204] Received SASL authentication start
I1028 21:39:22.600972 26708 authenticator.cpp:326] Authentication requires more steps
I1028 21:39:22.601096 26694 authenticatee.cpp:259] Received SASL authentication step
I1028 21:39:22.601127 26699 slave.cpp:4810] Finished recovery
I1028 21:39:22.601227 26694 authenticator.cpp:232] Received SASL authentication step
I1028 21:39:22.601261 26694 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '885c22ee76ba' server FQDN: '885c22ee76ba' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I1028 21:39:22.601277 26694 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1028 21:39:22.601321 26694 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1028 21:39:22.601346 26694 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '885c22ee76ba' server FQDN: '885c22ee76ba' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I1028 21:39:22.601359 26694 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1028 21:39:22.601369 26694 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1028 21:39:22.601388 26694 authenticator.cpp:318] Authentication success
I1028 21:39:22.601536 26693 authenticatee.cpp:299] Authentication success
I1028 21:39:22.601574 26704 master.cpp:5939] Successfully authenticated principal 'test-principal' at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:22.601634 26707 authenticator.cpp:432] Authentication session cleanup for crammd5_authenticatee(648)@172.17.0.3:58880
I1028 21:39:22.601814 26699 slave.cpp:4982] Querying resource estimator for oversubscribable resources
I1028 21:39:22.601953 26694 sched.cpp:502] Successfully authenticated with master master@172.17.0.3:58880
I1028 21:39:22.601984 26694 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.3:58880
I1028 21:39:22.602134 26694 sched.cpp:853] Will retry registration in 1.055598001secs if necessary
I1028 21:39:22.602161 26698 slave.cpp:895] New master detected at master@172.17.0.3:58880
I1028 21:39:22.602165 26695 status_update_manager.cpp:174] Pausing sending status updates
I1028 21:39:22.602195 26698 slave.cpp:954] Authenticating with master master@172.17.0.3:58880
I1028 21:39:22.602257 26698 slave.cpp:965] Using default CRAM-MD5 authenticatee
I1028 21:39:22.602267 26706 master.cpp:2429] Received SUBSCRIBE call for framework 'default' at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:22.602288 26706 master.cpp:1886] Authorizing framework principal 'test-principal' to receive offers for role 'role'
I1028 21:39:22.602423 26698 slave.cpp:927] Detecting new master
W1028 21:39:38.387270 26698 slave.cpp:1068] Authentication timed out
I1028 21:39:22.602458 26696 authenticatee.cpp:121] Creating new client SASL connection
I1028 21:39:22.602785 26697 master.cpp:2505] Subscribing framework default with checkpointing disabled and capabilities [  ]
I1028 21:39:23.658922 26700 sched.cpp:820] Sending SUBSCRIBE call to master@172.17.0.3:58880
I1028 21:39:38.387719 26700 sched.cpp:853] Will retry registration in 2.268966714secs if necessary
I1028 21:39:22.604964 26708 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.388030 26708 hierarchical.cpp:1170] Performed allocation for 0 agents in 15.783128446secs
W1028 21:39:38.388310 26696 slave.cpp:1013] Failed to authenticate with master master@172.17.0.3:58880: Authentication discarded
I1028 21:39:38.388842 26708 hierarchical.cpp:269] Added framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000
I1028 21:39:38.388938 26708 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.388977 26708 hierarchical.cpp:1630] No inverse offers to send out!
I1028 21:39:38.389056 26708 hierarchical.cpp:1170] Performed allocation for 0 agents in 195995ns
I1028 21:39:38.390779 26697 master.cpp:5909] Authenticating (11943)@172.17.0.3:58880
I1028 21:39:38.390951 26701 authenticator.cpp:414] Starting authentication session for crammd5_authenticatee(649)@172.17.0.3:58880
I1028 21:39:38.391257 26697 master.cpp:2429] Received SUBSCRIBE call for framework 'default' at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
../../src/tests/reservation_tests.cpp:1263: Failure
Actual function call count doesn't match EXPECT_CALL(sched, resourceOffers(&driver, _))...
         Expected: to be called at least once
           Actual: never called - unsatisfied and active
../../src/tests/reservation_tests.cpp:1261: Failure
Actual function call count doesn't match EXPECT_CALL(sched, registered(&driver, _, _))...
         Expected: to be called once
           Actual: never called - unsatisfied and active
I1028 21:39:38.391295 26697 master.cpp:1886] Authorizing framework principal 'test-principal' to receive offers for role 'role'
I1028 21:39:38.391486 26693 authenticator.cpp:432] Authentication session cleanup for crammd5_authenticatee(649)@172.17.0.3:58880
I1028 21:39:38.391585 26697 master.cpp:1284] Framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000 (default) at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880 disconnected
I1028 21:39:38.391629 26697 master.cpp:2735] Disconnecting framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000 (default) at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:38.391680 26697 master.cpp:2759] Deactivating framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000 (default) at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:38.391793 26697 master.cpp:1297] Giving framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000 (default) at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880 0ns to failover
I1028 21:39:38.391846 26701 hierarchical.cpp:380] Deactivated framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000
W1028 21:39:38.391994 26697 master.cpp:5936] Failed to authenticate (11943)@172.17.0.3:58880: Failed to communicate with authenticatee
I1028 21:39:38.392096 26697 master.cpp:2499] Dropping SUBSCRIBE call for framework 'default' at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880: Framework at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880 is not authenticated
I1028 21:39:38.393244 26706 master.cpp:5590] Framework failover timeout, removing framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000 (default) at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:38.393285 26706 master.cpp:6325] Removing framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000 (default) at scheduler-c6cdcae8-79c6-4be0-9e2b-359d364c5488@172.17.0.3:58880
I1028 21:39:38.396333 26694 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.396493 26694 hierarchical.cpp:1630] No inverse offers to send out!
I1028 21:39:38.396903 26694 hierarchical.cpp:1170] Performed allocation for 0 agents in 1.666494ms
I1028 21:39:38.397552 26694 hierarchical.cpp:331] Removed framework b14d26b9-9944-4a41-9bbf-013ab768821c-0000
lt-mesos-tests: ../../3rdparty/libprocess/include/process/dispatch.hpp:229: auto process::dispatch(const PID<mesos::internal::slave::Slave> &, void (mesos::internal::slave::Slave::*)(const process::Future<Option<mesos::MasterInfo> > &), process::Future<Option<mesos::MasterInfo> >)::(anonymous class)::operator()(process::ProcessBase *) const: Assertion `t != nullptr' failed.
*** Aborted at 1477690778 (unix time) try "date -d @1477690778" if you are using GNU date ***
PC: @     0x2ada7ceaec37 (unknown)
*** SIGABRT (@0x3e800006833) received by PID 26675 (TID 0x2ada86c75700) from PID 26675; stack trace: ***
I1028 21:39:38.399857 26675 master.cpp:1092] Master terminating
    @     0x2ada7cc6a330 (unknown)
    @     0x2ada7ceaec37 (unknown)
    @     0x2ada7ceb2028 (unknown)
    @     0x2ada7cea7bf6 (unknown)
    @     0x2ada7cea7ca2 (unknown)
I1028 21:39:38.402739 26693 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.402827 26693 hierarchical.cpp:1170] Performed allocation for 0 agents in 227627ns
[  FAILED  ] ReservationTest.IncompatibleCheckpointedResources (15857 ms)
[ RUN      ] ReservationTest.GoodACLReserveThenUnreserve
    @     0x2ada79bd26a6 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureI6OptionINS1_10MasterInfoEEEES9_EEvRKNS_3PIDIT_EEMSD_FvT0_ET1_ENKUlPNS_11ProcessBaseEE_clESM_
I1028 21:39:38.410835 26675 cluster.cpp:155] Creating default 'local' authorizer
I1028 21:39:38.413882 26675 leveldb.cpp:174] Opened db in 2.493745ms
I1028 21:39:38.414728 26675 leveldb.cpp:181] Compacted db in 820781ns
I1028 21:39:38.414774 26675 leveldb.cpp:196] Created db iterator in 31713ns
I1028 21:39:38.414801 26675 leveldb.cpp:202] Seeked to beginning of db in 12617ns
I1028 21:39:38.414821 26675 leveldb.cpp:271] Iterated through 0 keys in the db in 8773ns
I1028 21:39:38.414870 26675 replica.cpp:779] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned
I1028 21:39:38.415534 26701 recover.cpp:451] Starting replica recovery
I1028 21:39:38.415791 26701 recover.cpp:477] Replica is in EMPTY status
I1028 21:39:38.416623 26701 replica.cpp:673] Replica in EMPTY status received a broadcasted recover request from (11951)@172.17.0.3:58880
I1028 21:39:38.417222 26705 recover.cpp:197] Received a recover response from a replica in EMPTY status
I1028 21:39:38.417807 26699 recover.cpp:568] Updating replica status to STARTING
I1028 21:39:38.418576 26704 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 558365ns
I1028 21:39:38.418601 26704 replica.cpp:320] Persisted replica status to STARTING
I1028 21:39:38.418773 26704 recover.cpp:477] Replica is in STARTING status
I1028 21:39:38.419119 26695 master.cpp:375] Master 2266123c-c51f-4717-911e-36c0fe697af1 (885c22ee76ba) started on 172.17.0.3:58880
I1028 21:39:38.419533 26705 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from (11952)@172.17.0.3:58880
I1028 21:39:38.419157 26695 master.cpp:377] Flags at startup: --acls="reserve_resources {
  principals {
    values: "test-principal"
  }
  roles {
    type: ANY
  }
}
unreserve_resources {
  principals {
    values: "test-principal"
  }
  reserver_principals {
    values: "test-principal"
  }
}
" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="5ms" --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/GmjLmS/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --quiet="false" --recovery_agent_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --roles="role" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.0.2/_inst/share/mesos/webui" --work_dir="/tmp/GmjLmS/master" --zk_session_timeout="10secs"
I1028 21:39:38.419724 26695 master.cpp:427] Master only allowing authenticated frameworks to register
I1028 21:39:38.419739 26695 master.cpp:441] Master only allowing authenticated agents to register
I1028 21:39:38.419749 26695 master.cpp:454] Master only allowing authenticated HTTP frameworks to register
I1028 21:39:38.419759 26695 credentials.hpp:37] Loading credentials for authentication from '/tmp/GmjLmS/credentials'
I1028 21:39:38.419927 26696 recover.cpp:197] Received a recover response from a replica in STARTING status
I1028 21:39:38.420081 26695 master.cpp:499] Using default 'crammd5' authenticator
I1028 21:39:38.420207 26695 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1028 21:39:38.420243 26701 recover.cpp:568] Updating replica status to VOTING
I1028 21:39:38.420393 26695 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1028 21:39:38.420521 26695 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1028 21:39:38.420539 26706 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 183052ns
I1028 21:39:38.420560 26706 replica.cpp:320] Persisted replica status to VOTING
I1028 21:39:38.420624 26695 master.cpp:579] Authorization enabled
W1028 21:39:38.420640 26695 master.cpp:642] The '--roles' flag is deprecated. This flag will be removed in the future. See the Mesos 0.27 upgrade notes for more information
I1028 21:39:38.420706 26703 recover.cpp:582] Successfully joined the Paxos group
I1028 21:39:38.420842 26708 hierarchical.cpp:149] Initialized hierarchical allocator process
I1028 21:39:38.420858 26697 whitelist_watcher.cpp:77] No whitelist given
I1028 21:39:38.420892 26703 recover.cpp:466] Recover process terminated
I1028 21:39:38.423411 26699 master.cpp:1847] The newly elected leader is master@172.17.0.3:58880 with id 2266123c-c51f-4717-911e-36c0fe697af1
I1028 21:39:38.423442 26699 master.cpp:1860] Elected as the leading master!
I1028 21:39:38.423454 26699 master.cpp:1547] Recovering from registrar
I1028 21:39:38.423553 26701 registrar.cpp:332] Recovering registrar
I1028 21:39:38.424041 26698 log.cpp:553] Attempting to start the writer
    @     0x2ada79bd2362 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureI6OptionINS5_10MasterInfoEEEESD_EEvRKNS0_3PIDIT_EEMSH_FvT0_ET1_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
I1028 21:39:38.425719 26694 replica.cpp:493] Replica received implicit promise request from (11956)@172.17.0.3:58880 with proposal 1
I1028 21:39:38.426159 26694 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 413373ns
I1028 21:39:38.426190 26694 replica.cpp:342] Persisted promised to 1
I1028 21:39:38.426270 26705 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.426364 26705 hierarchical.cpp:1170] Performed allocation for 0 agents in 159329ns
I1028 21:39:38.426986 26698 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1028 21:39:38.428338 26699 replica.cpp:388] Replica received explicit promise request from (11957)@172.17.0.3:58880 for position 0 with proposal 2
I1028 21:39:38.428583 26699 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 208375ns
I1028 21:39:38.428616 26699 replica.cpp:712] Persisted action at 0
I1028 21:39:38.429906 26708 replica.cpp:537] Replica received write request for position 0 from (11958)@172.17.0.3:58880
I1028 21:39:38.429980 26708 leveldb.cpp:436] Reading position from leveldb took 48294ns
I1028 21:39:38.430358 26708 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 343296ns
I1028 21:39:38.430390 26708 replica.cpp:712] Persisted action at 0
I1028 21:39:38.431082 26705 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I1028 21:39:38.431269 26705 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 160689ns
I1028 21:39:38.431305 26705 replica.cpp:712] Persisted action at 0
I1028 21:39:38.431341 26705 replica.cpp:697] Replica learned NOP action at position 0
I1028 21:39:38.432121 26708 log.cpp:569] Writer started with ending position 0
I1028 21:39:38.432181 26703 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.432262 26703 hierarchical.cpp:1170] Performed allocation for 0 agents in 129905ns
I1028 21:39:38.433327 26704 leveldb.cpp:436] Reading position from leveldb took 66043ns
I1028 21:39:38.434450 26705 registrar.cpp:365] Successfully fetched the registry (0B) in 10.856192ms
I1028 21:39:38.434597 26705 registrar.cpp:464] Applied 1 operations in 41526ns; attempting to update the 'registry'
    @     0x2ada7aa3e258 std::function<>::operator()()
I1028 21:39:38.435365 26702 log.cpp:577] Attempting to append 168 bytes to the log
I1028 21:39:38.435554 26695 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I1028 21:39:38.436300 26698 replica.cpp:537] Replica received write request for position 1 from (11959)@172.17.0.3:58880
I1028 21:39:38.436671 26698 leveldb.cpp:341] Persisting action (187 bytes) to leveldb took 336836ns
I1028 21:39:38.436697 26698 replica.cpp:712] Persisted action at 1
I1028 21:39:38.437212 26695 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I1028 21:39:38.437397 26695 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 165418ns
I1028 21:39:38.437423 26695 replica.cpp:712] Persisted action at 1
I1028 21:39:38.437475 26695 replica.cpp:697] Replica learned APPEND action at position 1
I1028 21:39:38.437719 26700 hierarchical.cpp:1535] No allocations performed
I1028 21:39:38.437789 26700 hierarchical.cpp:1170] Performed allocation for 0 agents in 156568ns
I1028 21:39:38.438483 26708 registrar.cpp:509] Successfully updated the 'registry' in 3.828992ms
I1028 21:39:38.438642 26708 registrar.cpp:395] Successfully recovered registrar
I1028 21:39:38.438688 26698 log.cpp:596] Attempting to truncate the log to 1
I1028 21:39:38.438860 26702 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I1028 21:39:38.439219 26708 master.cpp:1655] Recovered 0 agents from the Registry (129B) ; allowing 10mins for agents to re-register
I1028 21:39:38.439251 26704 hierarchical.cpp:176] Skipping recovery of hierarchical allocator: nothing to recover
I1028 21:39:38.439743 26705 replica.cpp:537] Replica received write request for position 2 from (11960)@172.17.0.3:58880
I1028 21:39:38.440099 26705 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 334644ns
I1028 21:39:38.440121 26705 replica.cpp:712] Persisted action at 2
I1028 21:39:38.440610 26705 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I1028 21:39:38.440757 26705 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 131235ns
I1028 21:39:38.440807 26705 leveldb.cpp:399] Deleting ~1 keys from leveldb took 34946ns
I1028 21:39:38.440830 26705 replica.cpp:712] Persisted action at 2
I1028 21:39:38.440856 26705 replica.cpp:697] Replica learned TRUNCATE action at position 2
    @     0x2ada7aa255d4 process::ProcessBase::visit()
    @     0x2ada7aa8344e process::DispatchEvent::visit()
    @           0x8ab4f1 process::ProcessBase::serve()
    @     0x2ada7aa232d4 process::ProcessManager::resume()
    @     0x2ada7aa2e23c process::ProcessManager::init_threads()::$_0::operator()()
    @     0x2ada7aa2e145 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_0vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
    @     0x2ada7aa2e115 std::_Bind_simple<>::operator()()
    @     0x2ada7aa2e0ec std::thread::_Impl<>::_M_run()
    @     0x2ada7c4eba60 (unknown)
    @     0x2ada7cc62184 start_thread
    @     0x2ada7cf7237d (unknown)
make[4]: *** [check-local] Aborted
make[4]: Leaving directory `/mesos/mesos-1.0.2/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.0.2/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.0.2/_build/src'
make[1]: Leaving directory `/mesos/mesos-1.0.2/_build'
make[1]: *** [check-recursive] Error 1
make: *** [distcheck] Error 1
+ docker rmi mesos-1477688868-1656
Untagged: mesos-1477688868-1656:latest
Deleted: sha256:b0323f7bdaee1621d5b192bfe0dadbce62c170dfa35bc75805c000762b3d803f
Deleted: sha256:02991093fb51b34d00db447a0ca24ca44a8b74f95a8c17980ab0572733d14cdb
Deleted: sha256:75d4583338e8e9a6f9bdfdd9e8b9558fcdb3e00fd115db0aa7a5f7ea87853e11
Deleted: sha256:813c7f9a9b8d0e050ae2cd86571f21181b835c255a819f0cdac43ed5e04aa6b7
Deleted: sha256:69a81c866b33c70e807cd34ef607371fa52d419b0e0a06d843f88c081710876c
Deleted: sha256:f0afe35c12ffce4e7d1f99542b13273517644f15a098dddc4528b68707466dd3
Deleted: sha256:8d321f1597d20c1eab6399590408146eea879f8dcd52162688dd00b917619d3a
Deleted: sha256:26ef2ca2ab5625c9889a369c6bb3931a79ce34b4cd91eacbf483247c7d3d85f6
Deleted: sha256:ff6e94c593dfb0d1503131f3f2b82bd40c02eec046ab28fbd5d0e3bdebbbce11
Deleted: sha256:368446fdc2b8da6a01891ff63ecdcdcb2d68af3d261235750e59a500dea57b80
Deleted: sha256:4dcd818f2f79fdc8fdebc4476d0cac8bf0ba6c0e001c3393ccb5117c3030c6b3
Deleted: sha256:b01c24935b5eae2049d45c29b3df6e72a2e07e9922752b510341cd531c01225b
Deleted: sha256:04cc0eea44269bf51e578c5d737ad9b4aaa61443391d9d7ba0f7609018e05492
Deleted: sha256:be53f5a3ba26be4e7f3de36a47db23b7ee3a33e7571d91d1f52ec1d83e3af8d3
Deleted: sha256:405a4ab1f7d6cb662f666cf8ffa41c2057d4650ae0a5dd3676bff66bcc27fa21
Deleted: sha256:1154600d49d469e8f908a971e892b12e7bc6aa6d4d49b5fcc3deacec98dc1c3d
Deleted: sha256:c521b58f6d00e90c1fb155f6f60b73e07aae44ba107a65959051222921aeba16
Deleted: sha256:acce02c66b8d200143c6244e7cb98db3a07bbe68ff8b3d055cccb481f3be5d3e
Deleted: sha256:2ac00acc2c02a108691358d291b8fdd01cd878291e8dd98e3e084c4e6ee5404a
Deleted: sha256:dfa4cf8ad924c6202e8fbba6fdb7828d322cac34b46bf27cb37f8cdbac46046f
Deleted: sha256:bcd781489071ea7c825905bc848d961a46f4a842b98b80aaef439b1112f82f23
Deleted: sha256:674bb8f422ef033817035b6bd996ff2c5ee7efdccbcdd6473bf37e3415238081
Build step 'Execute shell' marked build as failure

Build failed in Jenkins: Mesos » autotools,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2843

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2843/changes>

Changes:

[anand] Added `MasterInfo` to the subscribed event.

[anand] Populated `MasterInfo` evolving from v0 framework registered message.

[anand] Populated `MasterInfo` in the v0 Java adapter.

[xujyan] Avoided CHECK failure with pre-1.0 agents.

[xujyan] Fixed master that leaks empty entries in its hashmaps.

[xujyan] Added MESOS-4975, MESOS-6482 and MESOS-6483 to CHANGLOG for 1.1.0.

------------------------------------------
[...truncated 210534 lines...]
W1028 19:39:00.078130 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.078268 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.081506 27698 slave.cpp:208] Mesos agent started on (619)@172.17.0.3:45832
I1028 19:39:00.081563 27698 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_to9iMW/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_to9iMW/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_to9iMW/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_to9iMW" --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_1_WIhrut"
I1028 19:39:00.082201 27698 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_to9iMW/credential'
I1028 19:39:00.082433 27698 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.082468 27698 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_to9iMW/http_credentials'
I1028 19:39:00.082788 27698 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.082989 27698 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.084064 27698 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.084142 27698 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.084166 27698 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.085607 27695 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_1_WIhrut/meta'
I1028 19:39:00.085711 27698 process.cpp:3377] Handling HTTP event for process 'slave(619)' with path: '/slave(619)/monitor/statistics.json'
I1028 19:39:00.086176 27685 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.086472 27688 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.086582 27694 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 19:39:00.087827 27688 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.088146 27694 slave.cpp:5281] Finished recovery
I1028 19:39:00.088732 27694 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.088912 27687 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.089793 27698 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (20 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I1028 19:39:00.098227 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.098788 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.098950 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.101625 27688 slave.cpp:208] Mesos agent started on (620)@172.17.0.3:45832
I1028 19:39:00.101665 27688 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Pxjw7P/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Pxjw7P/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Pxjw7P/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Pxjw7P" --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_wfikMm"
I1028 19:39:00.102133 27688 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Pxjw7P/credential'
I1028 19:39:00.102306 27688 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.102327 27688 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_Pxjw7P/http_credentials'
I1028 19:39:00.102576 27688 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.102727 27688 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.103914 27688 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.103987 27688 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.104001 27688 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.105491 27698 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_wfikMm/meta'
I1028 19:39:00.105581 27688 process.cpp:3377] Handling HTTP event for process 'slave(620)' with path: '/slave(620)/containers'
I1028 19:39:00.106010 27687 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.106148 27686 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.106439 27696 http.cpp:839] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 19:39:00.107579 27686 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.107841 27693 slave.cpp:5281] Finished recovery
I1028 19:39:00.108388 27693 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.108597 27690 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.109464 27697 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (19 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I1028 19:39:00.117957 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.118525 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.118672 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.121430 27697 slave.cpp:208] Mesos agent started on (621)@172.17.0.3:45832
I1028 19:39:00.121490 27697 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xLRxFJ/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xLRxFJ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xLRxFJ/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xLRxFJ" --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_WK98gg"
I1028 19:39:00.122027 27697 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xLRxFJ/credential'
I1028 19:39:00.122232 27697 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.122258 27697 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xLRxFJ/http_credentials'
I1028 19:39:00.122531 27697 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.122675 27697 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.123994 27697 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.124071 27697 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.124083 27697 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.125546 27697 process.cpp:3377] Handling HTTP event for process 'slave(621)' with path: '/slave(621)/monitor/statistics'
I1028 19:39:00.125874 27689 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_WK98gg/meta'
I1028 19:39:00.126055 27695 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.126480 27684 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.126613 27698 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 19:39:00.127720 27687 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.127944 27695 slave.cpp:5281] Finished recovery
I1028 19:39:00.128491 27695 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.128657 27698 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.129518 27693 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (19 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I1028 19:39:00.137842 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.138396 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.138545 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.141232 27695 slave.cpp:208] Mesos agent started on (622)@172.17.0.3:45832
I1028 19:39:00.141271 27695 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZVVwqD/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZVVwqD/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZVVwqD/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZVVwqD" --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_2aUTY9"
I1028 19:39:00.141885 27695 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZVVwqD/credential'
I1028 19:39:00.142066 27695 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.142093 27695 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ZVVwqD/http_credentials'
I1028 19:39:00.142319 27695 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.142443 27695 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.143517 27695 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.143592 27695 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.143606 27695 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.145036 27683 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_2aUTY9/meta'
I1028 19:39:00.145155 27695 process.cpp:3377] Handling HTTP event for process 'slave(622)' with path: '/slave(622)/monitor/statistics.json'
I1028 19:39:00.145611 27694 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.145828 27692 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.146107 27690 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 19:39:00.147083 27690 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.147382 27691 slave.cpp:5281] Finished recovery
I1028 19:39:00.148068 27691 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.148218 27691 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (17 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I1028 19:39:00.156237 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.156782 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.156940 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.159533 27688 slave.cpp:208] Mesos agent started on (623)@172.17.0.3:45832
I1028 19:39:00.159572 27688 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_XoCDnx/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_XoCDnx/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_XoCDnx/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_XoCDnx" --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_AGI1S3"
I1028 19:39:00.160027 27688 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_XoCDnx/credential'
I1028 19:39:00.160190 27688 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.160214 27688 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_XoCDnx/http_credentials'
I1028 19:39:00.160451 27688 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.160593 27688 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.161510 27688 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.161587 27688 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.161607 27688 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.162951 27693 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_AGI1S3/meta'
I1028 19:39:00.163066 27688 process.cpp:3377] Handling HTTP event for process 'slave(623)' with path: '/slave(623)/containers'
I1028 19:39:00.163473 27698 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.163631 27698 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.163939 27690 http.cpp:839] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 19:39:00.164988 27694 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.165252 27688 slave.cpp:5281] Finished recovery
I1028 19:39:00.165824 27688 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.166158 27694 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.166427 27685 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (18 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I1028 19:39:00.174541 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.175091 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.175254 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.176530 27665 cluster.cpp:435] Creating default 'local' authorizer
I1028 19:39:00.178004 27694 slave.cpp:208] Mesos agent started on (624)@172.17.0.3:45832
I1028 19:39:00.178043 27694 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vCetwr/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vCetwr/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vCetwr/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vCetwr" --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_UmVUYX"
I1028 19:39:00.178483 27694 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vCetwr/credential'
I1028 19:39:00.178668 27694 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.178692 27694 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_vCetwr/http_credentials'
I1028 19:39:00.178956 27694 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.179129 27694 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.180528 27694 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.180639 27694 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.180657 27694 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.182227 27698 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_UmVUYX/meta'
I1028 19:39:00.182324 27694 process.cpp:3377] Handling HTTP event for process 'slave(624)' with path: '/slave(624)/monitor/statistics'
I1028 19:39:00.182665 27684 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.182915 27685 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.183049 27694 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1028 19:39:00.184036 27689 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.184442 27698 slave.cpp:5281] Finished recovery
I1028 19:39:00.184957 27698 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.185132 27697 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.186350 27694 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (21 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I1028 19:39:00.197660 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.198439 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.198621 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.200206 27665 cluster.cpp:435] Creating default 'local' authorizer
I1028 19:39:00.202648 27695 slave.cpp:208] Mesos agent started on (625)@172.17.0.3:45832
I1028 19:39:00.202684 27695 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RSWXSl/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RSWXSl/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RSWXSl/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RSWXSl" --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_kPKQhS"
I1028 19:39:00.203105 27695 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RSWXSl/credential'
I1028 19:39:00.203307 27695 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.203331 27695 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_RSWXSl/http_credentials'
I1028 19:39:00.203552 27695 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.203683 27695 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.204705 27695 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.204792 27695 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.204807 27695 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.206233 27695 process.cpp:3377] Handling HTTP event for process 'slave(625)' with path: '/slave(625)/monitor/statistics.json'
I1028 19:39:00.206593 27694 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_kPKQhS/meta'
I1028 19:39:00.206923 27684 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.207010 27691 http.cpp:839] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1028 19:39:00.207211 27690 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.208292 27684 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.208497 27685 slave.cpp:5281] Finished recovery
I1028 19:39:00.209065 27685 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.209223 27689 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.210116 27696 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (23 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I1028 19:39:00.221201 27665 containerizer.cpp:200] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1028 19:39:00.221961 27665 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1028 19:39:00.222136 27665 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1028 19:39:00.223773 27665 cluster.cpp:435] Creating default 'local' authorizer
I1028 19:39:00.226130 27690 slave.cpp:208] Mesos agent started on (626)@172.17.0.3:45832
I1028 19:39:00.226161 27690 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_94ZSug/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_94ZSug/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_94ZSug/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_94ZSug" --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_EqhWPM"
I1028 19:39:00.226598 27690 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_94ZSug/credential'
I1028 19:39:00.226754 27690 slave.cpp:346] Agent using credential for: test-principal
I1028 19:39:00.226780 27690 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_94ZSug/http_credentials'
I1028 19:39:00.227033 27690 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1028 19:39:00.227176 27690 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1028 19:39:00.228248 27690 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1028 19:39:00.228322 27690 slave.cpp:541] Agent attributes: [  ]
I1028 19:39:00.228335 27690 slave.cpp:546] Agent hostname: 7ef1d0ca1739
I1028 19:39:00.229717 27695 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EqhWPM/meta'
I1028 19:39:00.229805 27690 process.cpp:3377] Handling HTTP event for process 'slave(626)' with path: '/slave(626)/containers'
I1028 19:39:00.230201 27687 status_update_manager.cpp:203] Recovering status update manager
I1028 19:39:00.230373 27690 containerizer.cpp:555] Recovering containerizer
I1028 19:39:00.230674 27683 http.cpp:839] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1028 19:39:00.231567 27690 provisioner.cpp:253] Provisioner recovery complete
I1028 19:39:00.231781 27693 slave.cpp:5281] Finished recovery
I1028 19:39:00.232259 27693 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I1028 19:39:00.232414 27684 slave.cpp:5469] Received oversubscribable resources {} from the resource estimator
I1028 19:39:00.233464 27697 slave.cpp:787] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (22 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (189 ms total)

[----------] Global test environment tear-down
[==========] 1356 tests from 154 test cases ran. (476605 ms total)
[  PASSED  ] 1353 tests.
[  FAILED  ] 3 tests, listed below:
[  FAILED  ] MasterTest.MaxCompletedFrameworksFlag
[  FAILED  ] PersistentVolumeEndpointsTest.SlavesEndpointFullResources
[  FAILED  ] ZooKeeperStateTest.FetchAndStoreAndExpungeAndExpunge

 3 FAILED TESTS
  YOU HAVE 5 DISABLED TESTS

make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.1.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.1.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.1.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.1.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1477681368-16214
Untagged: mesos-1477681368-16214:latest
Deleted: sha256:5eed7b2fb855bb160a45116f9e6869e5d5d8e5f0b4e1f39759c5ee0766c27b61
Deleted: sha256:f1dae677be70a652a10350e82999a3bdc72fd2163299824dbb5cc36eea690068
Deleted: sha256:87ba4a3c79e2148aa37db369a8451070fce0a410cfb48c1a8e1f98d053c350ae
Deleted: sha256:bb8041a3818ea31d24497a534669185f7efda990b86b96f94f98745c24ccd611
Deleted: sha256:5bf5c8d442e5904d48c4c05d266cc35d450d9cd70a6e39b6694a3a995a51d5fc
Deleted: sha256:e2645c78078c66554195451ce53f30982f2b4ef9e86b40f72ef23cc90884775f
Deleted: sha256:a45ad5856c70542606664198c08ad78e9fc5b45887bf80ad3874178c679396db
Deleted: sha256:7b9c1839f94260555dd7bd8418a56d01d2de2747cf9b70e50d412a4ebaaca351
Deleted: sha256:2b20e71ef4705a2c5305fddaf9d49f094c1d2e7f4e4a11d7d8149860770fdb9b
Deleted: sha256:a6982fd9fc2ee90f94c5793bcf947285ad142369323e4e7606da5f83d0c8db77
Deleted: sha256:1e13d29c85227681584df4f5797fd4710a9ead07a59af5a69ae3579ddb0d1f4c
Deleted: sha256:f2acb9796d2aed9086aec4aacf0a52e709f49e40628a859450284171e2d031dd
Deleted: sha256:596d141d1f382974603c0e6ca02a82dc6230abdf1ccf3aae7760e3ce9f55b8e3
Deleted: sha256:9cddf32fcaf46e586584484b2951f4386f97fa09543733d27c5e0dc770b8ef1f
Deleted: sha256:e0211d50fc5ab9ff7da7a0f262f940d1c46918b1f110f0702aaca339154fd9ed
Deleted: sha256:049460404cdb5b5bf4c6848dbe70673157cf2d3831f5aaa85ee233339e2401da
Deleted: sha256:ca6de157b59f9d2bc9a0fb5464f07a46fb86aa76aaafa496c472fab14248ab0f
Deleted: sha256:678b41dcd98e7e3f6696c56a674144100527eca8111b192281a11c1bc013a3f6
Deleted: sha256:f43724f885629bd4e52e4adca6b50f06cbdd5e33b05055731e21eedb13f076a1
Deleted: sha256:90ac22f14d82e2552feba3f8bc8765d4dcf33ed5357cce1fdbe8251c831c5df8
Deleted: sha256:639dc38fdd401b97036f5599b6ce8fe226798802b374f946d478fb5e159b38ee
Deleted: sha256:3372884de1c1486d09d0ea411390d3d7d67e292f986680094d1427fa8786c70d
Deleted: sha256:4fd09e234e64f48e241151f52f2925e9df846eb167f9eb04b827beb722c48403
Deleted: sha256:45ba5bc05b7997cf6b56b8f6b5b9af1d5156cc88b08deab88982d65e285504e5
Build step 'Execute shell' marked build as failure