You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/05/26 20:59:14 UTC

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3731

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3731/display/redirect?page=changes>

Changes:

[anand] Update vendored protobuf tar.gz to 3.3.0.

[anand] Remove unnecessary patch after protobuf upgrade to 3.3.0.

[anand] Update 3rdparty build to support protobuf 3.3.0.

[anand] Update related tests in stout to support protobuf 3.3.0.

[anand] Updated Mesos build library to use protobuf 3.3.0.

[anand] Added a test for evolving large protobuf message.

[anand] Updated LICENSE information for protobuf 3.3.0.

------------------------------------------
[...truncated 27.38 MB...]
I0526 20:58:59.417071  4855 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (36 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0526 20:58:59.428329  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.428874  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.428979  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.429013  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.432271  4848 slave.cpp:232] Mesos agent started on (747)@172.17.0.2:41066
I0526 20:58:59.432301  4848 slave.cpp:233] 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_AQLeVs/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_AQLeVs/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_AQLeVs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_AQLeVs" --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_WfovqL"
I0526 20:58:59.432911  4848 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_AQLeVs/credential'
I0526 20:58:59.433142  4848 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.433168  4848 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_AQLeVs/http_credentials'
I0526 20:58:59.433504  4848 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.433828  4848 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.435861  4848 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.435983  4848 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.436007  4848 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.436151  4859 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.438133  4851 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_WfovqL/meta'
I0526 20:58:59.438585  4862 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.438789  4861 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.440448  4866 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.440845  4844 slave.cpp:6073] Finished recovery
I0526 20:58:59.441468  4844 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.441900  4848 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.445101  4849 process.cpp:3730] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/containers'
I0526 20:58:59.446694  4865 http.cpp:1115] HTTP GET for /slave(747)/containers from 172.17.0.2:33168
I0526 20:58:59.446780  4865 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 20:58:59.450752  4855 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (33 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0526 20:58:59.461841  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.462414  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.462527  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.462564  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.466164  4853 slave.cpp:232] Mesos agent started on (748)@172.17.0.2:41066
I0526 20:58:59.466197  4853 slave.cpp:233] 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_3o00ah/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3o00ah/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3o00ah/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3o00ah" --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_xnIjBz"
I0526 20:58:59.466637  4853 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3o00ah/credential'
I0526 20:58:59.466838  4853 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.466857  4853 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_3o00ah/http_credentials'
I0526 20:58:59.467118  4853 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.467283  4853 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.468590  4853 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.468659  4853 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.468672  4853 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.468837  4846 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.470242  4861 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xnIjBz/meta'
I0526 20:58:59.470721  4853 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.470964  4850 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.472712  4843 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.473304  4863 slave.cpp:6073] Finished recovery
I0526 20:58:59.474012  4863 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.474371  4851 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.477509  4843 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/monitor/statistics'
I0526 20:58:59.479020  4856 http.cpp:1115] HTTP GET for /slave(748)/monitor/statistics from 172.17.0.2:33170
I0526 20:58:59.479115  4856 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 20:58:59.481835  4855 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0526 20:58:59.492723  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.493278  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.493386  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.493417  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.496614  4846 slave.cpp:232] Mesos agent started on (749)@172.17.0.2:41066
I0526 20:58:59.496642  4846 slave.cpp:233] 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_wFRtJ5/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_wFRtJ5/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_wFRtJ5/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_wFRtJ5" --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_c5xa5n"
I0526 20:58:59.497182  4846 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_wFRtJ5/credential'
I0526 20:58:59.497408  4846 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.497431  4846 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_wFRtJ5/http_credentials'
I0526 20:58:59.497710  4846 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.497855  4846 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.499145  4846 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.499213  4846 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.499225  4846 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.499359  4858 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.500856  4854 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_c5xa5n/meta'
I0526 20:58:59.501202  4843 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.501513  4856 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.503160  4864 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.503531  4844 slave.cpp:6073] Finished recovery
I0526 20:58:59.504134  4844 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.504467  4855 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.507603  4851 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
I0526 20:58:59.509078  4862 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics.json from 172.17.0.2:33172
I0526 20:58:59.509158  4862 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 20:58:59.511757  4863 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (29 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0526 20:58:59.522123  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.522683  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.522799  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.522835  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.526360  4859 slave.cpp:232] Mesos agent started on (750)@172.17.0.2:41066
I0526 20:58:59.526391  4859 slave.cpp:233] 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_VQ9yzU/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_VQ9yzU/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_VQ9yzU/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_VQ9yzU" --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_tFMSQc"
I0526 20:58:59.526965  4859 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_VQ9yzU/credential'
I0526 20:58:59.527191  4859 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.527217  4859 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_VQ9yzU/http_credentials'
I0526 20:58:59.527503  4859 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.527663  4859 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.528913  4859 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.528983  4859 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.528995  4859 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.529142  4858 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.530572  4844 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_tFMSQc/meta'
I0526 20:58:59.531049  4843 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.531257  4855 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.532799  4863 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.533298  4863 slave.cpp:6073] Finished recovery
I0526 20:58:59.533840  4863 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.534442  4863 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.537428  4852 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0526 20:58:59.538813  4855 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.2:33174
I0526 20:58:59.538887  4855 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 20:58:59.541714  4861 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0526 20:58:59.553452  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.553988  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.554100  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.554136  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.556313  4824 cluster.cpp:448] Creating default 'local' authorizer
I0526 20:58:59.558142  4860 slave.cpp:232] Mesos agent started on (751)@172.17.0.2:41066
I0526 20:58:59.558166  4860 slave.cpp:233] 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_YO8RHJ/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_YO8RHJ/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_YO8RHJ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_YO8RHJ" --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_bLgAU1"
I0526 20:58:59.558598  4860 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_YO8RHJ/credential'
I0526 20:58:59.558789  4860 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.558809  4860 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_YO8RHJ/http_credentials'
I0526 20:58:59.559057  4860 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.559227  4860 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.560494  4860 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.560562  4860 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.560575  4860 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.560714  4853 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.562116  4865 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_bLgAU1/meta'
I0526 20:58:59.562815  4866 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.563305  4860 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.564929  4856 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.565392  4857 slave.cpp:6073] Finished recovery
I0526 20:58:59.565980  4857 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.566292  4846 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.569103  4850 process.cpp:3730] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/monitor/statistics'
I0526 20:58:59.570461  4859 http.cpp:1115] HTTP GET for /slave(751)/monitor/statistics from 172.17.0.2:33176
I0526 20:58:59.570540  4859 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 20:58:59.573812  4859 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (31 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0526 20:58:59.585036  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.585602  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.585714  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.585760  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.587740  4824 cluster.cpp:448] Creating default 'local' authorizer
I0526 20:58:59.589568  4844 slave.cpp:232] Mesos agent started on (752)@172.17.0.2:41066
I0526 20:58:59.589586  4844 slave.cpp:233] 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_s1X78y/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_s1X78y/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_s1X78y/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_s1X78y" --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_GRO7gR"
I0526 20:58:59.589992  4844 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_s1X78y/credential'
I0526 20:58:59.590175  4844 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.590198  4844 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_s1X78y/http_credentials'
I0526 20:58:59.590461  4844 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.590627  4844 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.591933  4844 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.592002  4844 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.592015  4844 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.592144  4865 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.593542  4862 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_GRO7gR/meta'
I0526 20:58:59.593858  4855 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.594137  4853 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.595800  4844 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.596155  4865 slave.cpp:6073] Finished recovery
I0526 20:58:59.596698  4865 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.597196  4863 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.600317  4852 process.cpp:3730] Handling HTTP event for process 'slave(752)' with path: '/slave(752)/monitor/statistics.json'
I0526 20:58:59.601801  4853 http.cpp:1115] HTTP GET for /slave(752)/monitor/statistics.json from 172.17.0.2:33180
I0526 20:58:59.601888  4853 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 20:58:59.605698  4851 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0526 20:58:59.616164  4824 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 20:58:59.616680  4824 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 20:58:59.616781  4824 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 20:58:59.616813  4824 provisioner.cpp:255] Using default backend 'copy'
I0526 20:58:59.618957  4824 cluster.cpp:448] Creating default 'local' authorizer
I0526 20:58:59.620723  4858 slave.cpp:232] Mesos agent started on (753)@172.17.0.2:41066
I0526 20:58:59.620754  4858 slave.cpp:233] 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_EYkXSo/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EYkXSo/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EYkXSo/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EYkXSo" --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_RI7hWG"
I0526 20:58:59.621186  4858 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EYkXSo/credential'
I0526 20:58:59.621388  4858 slave.cpp:265] Agent using credential for: test-principal
I0526 20:58:59.621415  4858 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_EYkXSo/http_credentials'
I0526 20:58:59.621659  4858 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 20:58:59.621840  4858 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 20:58:59.623224  4858 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 20:58:59.623292  4858 slave.cpp:544] Agent attributes: [  ]
I0526 20:58:59.623306  4858 slave.cpp:549] Agent hostname: 75d8eed6a700
I0526 20:58:59.623446  4859 status_update_manager.cpp:177] Pausing sending status updates
I0526 20:58:59.624955  4854 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_RI7hWG/meta'
I0526 20:58:59.625313  4866 status_update_manager.cpp:203] Recovering status update manager
I0526 20:58:59.625524  4860 containerizer.cpp:582] Recovering containerizer
I0526 20:58:59.627092  4844 provisioner.cpp:416] Provisioner recovery complete
I0526 20:58:59.627517  4844 slave.cpp:6073] Finished recovery
I0526 20:58:59.627995  4844 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 20:58:59.628439  4866 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 20:58:59.631578  4850 process.cpp:3730] Handling HTTP event for process 'slave(753)' with path: '/slave(753)/containers'
I0526 20:58:59.632983  4848 http.cpp:1115] HTTP GET for /slave(753)/containers from 172.17.0.2:33188
I0526 20:58:59.633069  4848 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 20:58:59.637814  4824 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (34 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (290 ms total)

[----------] Global test environment tear-down
[==========] 1580 tests from 176 test cases ran. (476658 ms total)
[  PASSED  ] 1579 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0526 20:58:59.709173  4867 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495829464-8662
Untagged: mesos-1495829464-8662:latest
Deleted: sha256:28eac434022e3a52a0d17c4fd6c309188f88234feadf1a60cefb116a03f46a02
Deleted: sha256:93150ad431e3dc83f9048324a8d34bb941579f1b76ff6638f46380732708cd0f
Deleted: sha256:82434a27ec630214df8db077c4f82c609ed3ea3efc1a5bd6fc511e688663b464
Deleted: sha256:c2c1c4534f660e2a869e7cee444733e26264596deeaf4ca89c4fee38a05b16c9
Deleted: sha256:ab60534e6eec24ecf4c839ad7c495a46e87f9b28f871340640c89bbc10fcca40
Deleted: sha256:efcb551180c5c0d7321e967c41d3cd4f063e223c81b265323f88a80690461357
Deleted: sha256:303a0f3657ec24117f8384da5866d42ea9e4d237b5f48fc7757aafcd2fbcecf8
Deleted: sha256:a6f37398504d1a14ff678540120c0e59d00da1314a642f19f16831700fbf2804
Deleted: sha256:c970406213a51c83f2fed38cc30041c6b403db40373c08502567e58ac97fb5c3
Deleted: sha256:440911d79e7b992e9e64b76d9773a6eaa1d2cc4ed0316191e6c168082aaa9bdd
Deleted: sha256:23ff8223c4b1fe570d446319e3786b0afd79e53b208080064fe95eba1bc7dcce
Deleted: sha256:9516fed143ceaa8b330aa0d27b4fff54c3feb40607eee8344d6ad21e1b7e7d9f
Deleted: sha256:9be2cde294ed1fb494b9fb7f500b1c2d455efc68836ce005ccfcab39fab8cde9
Deleted: sha256:79112d354578301dfbcc0ef24c71c41f2608b8a22de935dd1f0d1aab3ce20e4c
Deleted: sha256:3553eb00e90759cf20791043c57693141cb02fc7f8105111a0e936063a4aa2dc
Deleted: sha256:66ce1caca823a7a6b33cb25d9d7fe7689a2983d106b18ee9d7e9ec8db28b06f4
Deleted: sha256:690272e9a784828040c134d82f9ad68420936edfc42cea7d6791ac74ad680a13
Deleted: sha256:26289fc2b3d5e63398dff9ad725944dd9b2dd52aa4a15e36daf6f673732917bf
Deleted: sha256:6891ffbb4b59b94c2576f01f08f0443e87d15de63ce01b5f8e42a3573e702023
Deleted: sha256:5fd9f91b82f8fd277cf4a2c464def630d300ab615e6729ddbe6d40600beaff99
Deleted: sha256:f28247d589868860b4bbdf44930f72f6ecbbd5c7dea03e2e7ba274357b4b84d3
Deleted: sha256:f3e30cbdc78e7c4ad9c4a65ba7ad80020ec6920c3ef4bf1d81cd7023b40d5892
Deleted: sha256:5d25ba477bc61c9a9d62d7cfbdd79aae4cc8d3604b5d5b73ff252e265d608efd
Deleted: sha256:fff05bfd972c65f8d33024df8639d37d35fdc117782f32f3718ae6196f97a555
Build step 'Execute shell' marked build as failure

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

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


Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3734

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

Changes:

[bmahler] Added a test for the optional executor reconnect retry in the agent.

[bmahler] Added a test for shutting down executors that re-register.

[bmahler] Added a test for ignoring executor re-registrations.

------------------------------------------
[...truncated 27.51 MB...]
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0527 03:16:28.971745  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:28.972306  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:28.972405  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:28.972437  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:28.976214  4700 slave.cpp:232] Mesos agent started on (751)@172.17.0.2:47759
I0527 03:16:28.976253  4700 slave.cpp:233] 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_9huL7i/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9huL7i/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9huL7i/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9huL7i" --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_VSbhmr"
I0527 03:16:28.976707  4700 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9huL7i/credential'
I0527 03:16:28.976932  4700 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:28.976953  4700 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_9huL7i/http_credentials'
I0527 03:16:28.977219  4700 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:28.977474  4700 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:28.979188  4700 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:28.979260  4700 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:28.979274  4700 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:28.979426  4692 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:28.980773  4694 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_VSbhmr/meta'
I0527 03:16:28.981127  4702 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:28.981351  4699 containerizer.cpp:582] Recovering containerizer
I0527 03:16:28.983536  4693 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:28.983978  4694 slave.cpp:6083] Finished recovery
I0527 03:16:28.984525  4694 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:28.984797  4692 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:28.988348  4693 process.cpp:3730] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/containers'
I0527 03:16:28.989905  4703 http.cpp:1115] HTTP GET for /slave(751)/containers from 172.17.0.2:45278
I0527 03:16:28.989984  4703 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 03:16:28.993700  4696 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (53 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0527 03:16:29.023564  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:29.024067  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:29.024235  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:29.024276  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:29.029417  4698 slave.cpp:232] Mesos agent started on (752)@172.17.0.2:47759
I0527 03:16:29.029445  4698 slave.cpp:233] 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_JBUFDM/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_JBUFDM/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_JBUFDM/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_JBUFDM" --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_hc1BJU"
I0527 03:16:29.029981  4698 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_JBUFDM/credential'
I0527 03:16:29.030197  4698 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:29.030223  4698 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_JBUFDM/http_credentials'
I0527 03:16:29.030560  4698 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:29.030772  4698 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:29.032503  4698 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:29.032668  4698 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:29.032694  4698 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:29.032886  4701 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:29.034504  4703 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_hc1BJU/meta'
I0527 03:16:29.034907  4689 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:29.035167  4692 containerizer.cpp:582] Recovering containerizer
I0527 03:16:29.037159  4702 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:29.037786  4703 slave.cpp:6083] Finished recovery
I0527 03:16:29.038440  4703 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:29.038811  4704 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:29.042052  4701 process.cpp:3730] Handling HTTP event for process 'slave(752)' with path: '/slave(752)/monitor/statistics'
I0527 03:16:29.043951  4698 http.cpp:1115] HTTP GET for /slave(752)/monitor/statistics from 172.17.0.2:45289
I0527 03:16:29.044067  4698 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0527 03:16:29.047276  4694 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (87 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0527 03:16:29.111421  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:29.111959  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:29.112063  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:29.112100  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:29.115429  4696 slave.cpp:232] Mesos agent started on (753)@172.17.0.2:47759
I0527 03:16:29.115455  4696 slave.cpp:233] 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_cNw1Yg/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_cNw1Yg/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_cNw1Yg/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_cNw1Yg" --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_WLCIQo"
I0527 03:16:29.115877  4696 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_cNw1Yg/credential'
I0527 03:16:29.116037  4696 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:29.116055  4696 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_cNw1Yg/http_credentials'
I0527 03:16:29.116281  4696 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:29.116430  4696 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:29.117662  4696 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:29.117735  4696 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:29.117754  4696 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:29.117898  4704 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:29.119472  4691 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WLCIQo/meta'
I0527 03:16:29.119843  4698 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:29.120046  4693 containerizer.cpp:582] Recovering containerizer
I0527 03:16:29.121681  4691 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:29.122088  4700 slave.cpp:6083] Finished recovery
I0527 03:16:29.131625  4700 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:29.132097  4701 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:29.135574  4702 process.cpp:3730] Handling HTTP event for process 'slave(753)' with path: '/slave(753)/monitor/statistics.json'
I0527 03:16:29.137080  4700 http.cpp:1115] HTTP GET for /slave(753)/monitor/statistics.json from 172.17.0.2:45302
I0527 03:16:29.137182  4700 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0527 03:16:29.139724  4693 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (40 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0527 03:16:29.153190  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:29.153842  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:29.153966  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:29.154007  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:29.158365  4701 slave.cpp:232] Mesos agent started on (754)@172.17.0.2:47759
I0527 03:16:29.158390  4701 slave.cpp:233] 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_IEntTL/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_IEntTL/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_IEntTL/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_IEntTL" --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_SSFuET"
I0527 03:16:29.159035  4701 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_IEntTL/credential'
I0527 03:16:29.159278  4701 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:29.159303  4701 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_IEntTL/http_credentials'
I0527 03:16:29.159605  4701 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:29.159771  4701 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:29.161437  4701 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:29.161526  4701 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:29.161542  4701 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:29.161780  4695 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:29.163177  4694 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_SSFuET/meta'
I0527 03:16:29.163650  4693 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:29.163907  4698 containerizer.cpp:582] Recovering containerizer
I0527 03:16:29.165956  4692 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:29.166580  4696 slave.cpp:6083] Finished recovery
I0527 03:16:29.173774  4696 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:29.174113  4702 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:29.177119  4697 process.cpp:3730] Handling HTTP event for process 'slave(754)' with path: '/slave(754)/containers'
I0527 03:16:29.178570  4697 http.cpp:1115] HTTP GET for /slave(754)/containers from 172.17.0.2:45306
I0527 03:16:29.178663  4697 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 03:16:29.181097  4696 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (39 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0527 03:16:29.191687  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:29.192214  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:29.192332  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:29.192395  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:29.194872  4670 cluster.cpp:448] Creating default 'local' authorizer
I0527 03:16:29.196882  4691 slave.cpp:232] Mesos agent started on (755)@172.17.0.2:47759
I0527 03:16:29.196916  4691 slave.cpp:233] 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_uiT2dh/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uiT2dh/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uiT2dh/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uiT2dh" --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_02CGSo"
I0527 03:16:29.197481  4691 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uiT2dh/credential'
I0527 03:16:29.231503  4691 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:29.231549  4691 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_uiT2dh/http_credentials'
I0527 03:16:29.231889  4691 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:29.232141  4691 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:29.233422  4691 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:29.233499  4691 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:29.233510  4691 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:29.233666  4700 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:29.235332  4703 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_02CGSo/meta'
I0527 03:16:29.235772  4694 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:29.235993  4689 containerizer.cpp:582] Recovering containerizer
I0527 03:16:29.237431  4704 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:29.237792  4693 slave.cpp:6083] Finished recovery
I0527 03:16:29.238306  4693 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:29.238658  4697 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:29.242202  4692 process.cpp:3730] Handling HTTP event for process 'slave(755)' with path: '/slave(755)/monitor/statistics'
I0527 03:16:29.243692  4689 http.cpp:1115] HTTP GET for /slave(755)/monitor/statistics from 172.17.0.2:45320
I0527 03:16:29.243772  4689 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0527 03:16:29.247316  4701 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (66 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0527 03:16:29.258905  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:29.259402  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:29.259503  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:29.259538  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:29.261273  4670 cluster.cpp:448] Creating default 'local' authorizer
I0527 03:16:29.262881  4693 slave.cpp:232] Mesos agent started on (756)@172.17.0.2:47759
I0527 03:16:29.262909  4693 slave.cpp:233] 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_ychKfN/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_ychKfN/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_ychKfN/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_ychKfN" --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_6s6tJU"
I0527 03:16:29.263460  4693 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_ychKfN/credential'
I0527 03:16:29.263664  4693 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:29.263689  4693 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_ychKfN/http_credentials'
I0527 03:16:29.263967  4693 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:29.264145  4693 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:29.265646  4693 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:29.265733  4693 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:29.265748  4693 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:29.265904  4702 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:29.267457  4692 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_6s6tJU/meta'
I0527 03:16:29.267822  4694 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:29.268041  4702 containerizer.cpp:582] Recovering containerizer
I0527 03:16:29.269928  4700 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:29.270406  4701 slave.cpp:6083] Finished recovery
I0527 03:16:29.270920  4701 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:29.271299  4694 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:29.274353  4700 process.cpp:3730] Handling HTTP event for process 'slave(756)' with path: '/slave(756)/monitor/statistics.json'
I0527 03:16:29.275825  4689 http.cpp:1115] HTTP GET for /slave(756)/monitor/statistics.json from 172.17.0.2:45325
I0527 03:16:29.275903  4689 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0527 03:16:29.279180  4697 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (59 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0527 03:16:29.320464  4670 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 03:16:29.321116  4670 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 03:16:29.321247  4670 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 03:16:29.321296  4670 provisioner.cpp:255] Using default backend 'copy'
I0527 03:16:29.323559  4670 cluster.cpp:448] Creating default 'local' authorizer
I0527 03:16:29.325588  4699 slave.cpp:232] Mesos agent started on (757)@172.17.0.2:47759
I0527 03:16:29.325616  4699 slave.cpp:233] 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_yxyQPj/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_yxyQPj/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_yxyQPj/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_yxyQPj" --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_y7EQ9q"
I0527 03:16:29.326190  4699 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_yxyQPj/credential'
I0527 03:16:29.326474  4699 slave.cpp:265] Agent using credential for: test-principal
I0527 03:16:29.326503  4699 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_yxyQPj/http_credentials'
I0527 03:16:29.326802  4699 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 03:16:29.326975  4699 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 03:16:29.328260  4699 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 03:16:29.328359  4699 slave.cpp:544] Agent attributes: [  ]
I0527 03:16:29.328374  4699 slave.cpp:549] Agent hostname: 25b1c1662401
I0527 03:16:29.328523  4700 status_update_manager.cpp:177] Pausing sending status updates
I0527 03:16:29.330003  4697 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_y7EQ9q/meta'
I0527 03:16:29.330423  4694 status_update_manager.cpp:203] Recovering status update manager
I0527 03:16:29.330658  4697 containerizer.cpp:582] Recovering containerizer
I0527 03:16:29.332350  4691 provisioner.cpp:416] Provisioner recovery complete
I0527 03:16:29.332815  4696 slave.cpp:6083] Finished recovery
I0527 03:16:29.333417  4696 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 03:16:29.333756  4692 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 03:16:29.336933  4704 process.cpp:3730] Handling HTTP event for process 'slave(757)' with path: '/slave(757)/containers'
I0527 03:16:29.339159  4704 http.cpp:1115] HTTP GET for /slave(757)/containers from 172.17.0.2:45338
I0527 03:16:29.339262  4704 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0527 03:16:29.344691  4670 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (66 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (501 ms total)

[----------] Global test environment tear-down
[==========] 1583 tests from 176 test cases ran. (713429 ms total)
[  PASSED  ] 1581 tests.
[  FAILED  ] 2 tests, listed below:
[  FAILED  ] ExamplesTest.PythonFramework
[  FAILED  ] IOSwitchboardTest.ContainerAttach

 2 FAILED TESTS
  YOU HAVE 22 DISABLED TESTS

E0527 03:16:29.469610  4705 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495850562-20834
Untagged: mesos-1495850562-20834:latest
Deleted: sha256:c8e34fe6c601c3dc6dbfbc36e9b12206cd0e62c375d32779e8482453666c9d58
Deleted: sha256:ab574f0e431fa407d330e46e4976f1d3529b8f1bf922da73f98db135c3c35fde
Deleted: sha256:1ab3c83f8768ffae6bef8de9400019e58cb7be7d1c4d597ade36a4544f85f9f5
Deleted: sha256:03619a9b06654acf38d316aeaf2fca99b2b1e4009a9bff3c8dd30872f32aa84a
Deleted: sha256:2838425ce8e5df0e0258c523ff492b15aa636da98f21c639f914eb06824ca9db
Deleted: sha256:ade43ab9f8597dfb579550abe58893ee8072a9eff6a630ffe01e737ccd182bb2
Deleted: sha256:5c62343fee93cb0490610e9687ee1629182065ab92cbc32fa112d56359bff688
Deleted: sha256:fbd905f4f1358b3600b088d7d356fb240099b86845308ce0d1257a36be0d5e80
Deleted: sha256:e0945772fed9533398f202a9b3ecdc231d4127eff3651f9b1092c3407f87047b
Deleted: sha256:61a7e55d5a2de7c9aaf5d4472bb3a65c46b087521ccaa2c5bda1fbf7cef4ca60
Deleted: sha256:879b2bd7c64c75ffa029387e2018469d1cfb7073cb3347e6a12e424323337ee0
Deleted: sha256:81c01a9fdcb03ad59e4a002e71c6def7f0ae82760f82c302267e90b8dbe43b7c
Deleted: sha256:c90294da88ec5029ecd4eb67a525e3e278b68a93f5b95d408e5fc7f1c1319ef5
Deleted: sha256:821f766cb4ff539a38b9b2dc74a8f8a9b91b1e4a2dd823d2b70015d83f613ba9
Deleted: sha256:97c5d1de7147ee9f2efe22a8e3440d77b5dbd13acfe95ce4aa76166d0776e611
Deleted: sha256:c37c89c7490f0d5c1a2bdfc28d68ad537bff7e95b7b36192539c7b2787d134c3
Deleted: sha256:4f8e9e05e520a61b821e10beddd9a314ba8fe47fb6c82c628bdef3ccc143b7dd
Deleted: sha256:d42f040f8aeea8ed025e10a6889bcad92a38223300b94777c315b6e4824e0670
Deleted: sha256:71ae0de12324dd0cb2ad9dd4942b71923c3e224b25bf9055698fc4141ae8d824
Deleted: sha256:95b51524d8ab66dbb41926f44cea0c182439a8f6312d5017b9a2dd765d1ff5cb
Deleted: sha256:a38edcccb2c17ae9b91430d47d76147ba8c48422913cdba7faa25fb9c2ccacf6
Deleted: sha256:76020f76f610dc970efdf2343c2bb4db68febb4fc5b019f23eab8c529298a9d0
Deleted: sha256:4e4adce67c763d6bd4f49944f0964468ba34f614144e4390f7fa8476952db136
Deleted: sha256:5d2a54a585ee40d30ceb75851c6ebb8df14a11217dcbf3c1d13be0b10baecdeb
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3733

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

Changes:

[bmahler] Don't crash when re-registering executor from an unknown framework.

[bmahler] Don't crash the agent when an unknown executor re-registers.

[bmahler] Removed a use of the 'default' switch case.

[bmahler] Added logging of executor re-registration messages.

[bmahler] Avoided use of [] operator for read only map access.

[bmahler] Minor logging cleanup to put open/close quotes on the same line.

------------------------------------------
[...truncated 15.15 MB...]
I0527 00:58:51.152112  4685 authenticatee.cpp:259] Received SASL authentication step
I0527 00:58:51.152295  4684 authenticator.cpp:232] Received SASL authentication step
I0527 00:58:51.152346  4684 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '31b7750c93d8' server FQDN: '31b7750c93d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0527 00:58:51.152377  4684 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0527 00:58:51.152441  4684 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0527 00:58:51.152475  4684 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '31b7750c93d8' server FQDN: '31b7750c93d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0527 00:58:51.152503  4684 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0527 00:58:51.152524  4684 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0527 00:58:51.152559  4684 authenticator.cpp:318] Authentication success
I0527 00:58:51.152698  4685 authenticatee.cpp:299] Authentication success
I0527 00:58:51.152926  4689 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(714)@172.17.0.3:58547
I0527 00:58:51.152933  4690 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(330)@172.17.0.3:58547
I0527 00:58:51.153224  4688 slave.cpp:1086] Successfully authenticated with master master@172.17.0.3:58547
I0527 00:58:51.153503  4688 slave.cpp:1506] Will retry registration in 3.92071ms if necessary
I0527 00:58:51.153750  4696 master.cpp:5429] Received register agent message from slave(330)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.153952  4696 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0527 00:58:51.154566  4695 master.cpp:5489] Authorized registration of agent at slave(330)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.154722  4695 master.cpp:5568] Registering agent at slave(330)@172.17.0.3:58547 (31b7750c93d8) with id 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0
I0527 00:58:51.155273  4697 registrar.cpp:493] Applied 1 operations in 75393ns; attempting to update the registry
I0527 00:58:51.156075  4697 registrar.cpp:550] Successfully updated the registry in 720128ns
I0527 00:58:51.156292  4686 master.cpp:5615] Admitted agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 at slave(330)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.156954  4691 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.157061  4686 master.cpp:5646] Registered agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 at slave(330)@172.17.0.3:58547 (31b7750c93d8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:58:51.157189  4691 slave.cpp:1132] Registered with master master@172.17.0.3:58547; given agent ID 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0
I0527 00:58:51.157340  4684 status_update_manager.cpp:184] Resuming sending status updates
I0527 00:58:51.157505  4694 hierarchical.cpp:525] Added agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 (31b7750c93d8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0527 00:58:51.157661  4691 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/PartitionTest_FailHealthChecksTwice_gJl2l4/meta/slaves/52304b29-7a89-4f7c-83d2-f9b4d7125919-S0/slave.info'
I0527 00:58:51.158113  4691 slave.cpp:1190] Forwarding total oversubscribed resources {}
I0527 00:58:51.158350  4691 master.cpp:6336] Received update of agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 at slave(330)@172.17.0.3:58547 (31b7750c93d8) with total oversubscribed resources {}
I0527 00:58:51.158915  4694 hierarchical.cpp:1944] No inverse offers to send out!
I0527 00:58:51.158975  4694 hierarchical.cpp:1438] Performed allocation for 1 agents in 1.264224ms
I0527 00:58:51.159489  4683 master.cpp:7317] Sending 1 offers to framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000 (default) at scheduler-232695a8-15d2-44f1-8cdd-3059eacf3c15@172.17.0.3:58547
I0527 00:58:51.160048  4683 sched.cpp:933] Scheduler::resourceOffers took 73113ns
I0527 00:58:51.162672  4690 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.162868  4689 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.162957  4689 hierarchical.cpp:1944] No inverse offers to send out!
I0527 00:58:51.163023  4689 hierarchical.cpp:1438] Performed allocation for 1 agents in 410864ns
I0527 00:58:51.163063  4690 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.163307  4690 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.165103  4691 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.165148  4693 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.165207  4693 hierarchical.cpp:1944] No inverse offers to send out!
I0527 00:58:51.165273  4693 hierarchical.cpp:1438] Performed allocation for 1 agents in 249621ns
I0527 00:58:51.165307  4691 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.165582  4691 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.167253  4686 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.167410  4686 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.167423  4684 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.167482  4684 hierarchical.cpp:1944] No inverse offers to send out!
I0527 00:58:51.167564  4684 hierarchical.cpp:1438] Performed allocation for 1 agents in 238871ns
I0527 00:58:51.167592  4686 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.169383  4685 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.169433  4685 hierarchical.cpp:1944] No inverse offers to send out!
I0527 00:58:51.169481  4685 hierarchical.cpp:1438] Performed allocation for 1 agents in 192810ns
I0527 00:58:51.169754  4696 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.169939  4696 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.170182  4696 slave.cpp:5730] Current disk usage 11.14%. Max allowed age: 5.520173695809595days
I0527 00:58:51.170397  4696 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.172302  4685 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.172320  4695 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.172363  4685 hierarchical.cpp:1944] No inverse offers to send out!
I0527 00:58:51.172428  4685 hierarchical.cpp:1438] Performed allocation for 1 agents in 230001ns
I0527 00:58:51.172462  4692 master.cpp:6708] Marking agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 at slave(330)@172.17.0.3:58547 (31b7750c93d8) unreachable: health check timed out
I0527 00:58:51.172543  4695 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.172698  4695 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.174341  4684 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.174646  4695 slave.cpp:4809] Received ping from slave-observer(336)@172.17.0.3:58547
I0527 00:58:51.174688  4690 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.174782  4690 hierarchical.cpp:1944] No inverse offers to send out!
W0527 00:58:51.174830  4696 master.cpp:6696] Not marking agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 unreachable because another unreachable transition is already in progress
I0527 00:58:51.174834  4695 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.174868  4690 hierarchical.cpp:1438] Performed allocation for 1 agents in 297540ns
I0527 00:58:51.175456  4686 registrar.cpp:493] Applied 1 operations in 91317ns; attempting to update the registry
I0527 00:58:51.176338  4686 registrar.cpp:550] Successfully updated the registry in 0ns
I0527 00:58:51.176582  4692 master.cpp:6756] Marked agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 at slave(330)@172.17.0.3:58547 (31b7750c93d8) unreachable: health check timed out
I0527 00:58:51.177263  4691 hierarchical.cpp:558] Removed agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0
I0527 00:58:51.177497  4687 sched.cpp:959] Rescinded offer 52304b29-7a89-4f7c-83d2-f9b4d7125919-O0
I0527 00:58:51.177587  4687 sched.cpp:970] Scheduler::offerRescinded took 29812ns
I0527 00:58:51.177767  4692 master.cpp:2078] Notifying framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000 (default) at scheduler-232695a8-15d2-44f1-8cdd-3059eacf3c15@172.17.0.3:58547 of lost agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0 (31b7750c93d8)
I0527 00:58:51.177979  4696 sched.cpp:1103] Lost agent 52304b29-7a89-4f7c-83d2-f9b4d7125919-S0
I0527 00:58:51.178040  4696 sched.cpp:1114] Scheduler::slaveLost took 28589ns
I0527 00:58:51.181736  4695 process.cpp:3730] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot'
I0527 00:58:51.182970  4690 http.cpp:798] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot'
I0527 00:58:51.211648  4664 sched.cpp:2021] Asked to stop the driver
I0527 00:58:51.211838  4696 sched.cpp:1203] Stopping framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000
I0527 00:58:51.212178  4686 master.cpp:8000] Processing TEARDOWN call for framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000 (default) at scheduler-232695a8-15d2-44f1-8cdd-3059eacf3c15@172.17.0.3:58547
I0527 00:58:51.212221  4686 master.cpp:8012] Removing framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000 (default) at scheduler-232695a8-15d2-44f1-8cdd-3059eacf3c15@172.17.0.3:58547
I0527 00:58:51.212249  4686 master.cpp:3160] Deactivating framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000 (default) at scheduler-232695a8-15d2-44f1-8cdd-3059eacf3c15@172.17.0.3:58547
I0527 00:58:51.212424  4695 hierarchical.cpp:374] Deactivated framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000
I0527 00:58:51.213502  4688 hierarchical.cpp:325] Removed framework 52304b29-7a89-4f7c-83d2-f9b4d7125919-0000
I0527 00:58:51.214872  4693 slave.cpp:801] Agent terminating
I0527 00:58:51.220664  4695 master.cpp:1155] Master terminating
[       OK ] PartitionTest.FailHealthChecksTwice (119 ms)
[----------] 16 tests from PartitionTest (23217 ms total)

[----------] 2 tests from OneWayPartitionTest
[ RUN      ] OneWayPartitionTest.MasterToSlave
I0527 00:58:51.228225  4664 cluster.cpp:162] Creating default 'local' authorizer
I0527 00:58:51.231214  4696 master.cpp:436] Master 35bab20d-2bf0-40b0-8b09-2474df0b8013 (31b7750c93d8) started on 172.17.0.3:58547
I0527 00:58:51.231240  4696 master.cpp:438] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/QWYbLV/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" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.4.0/_inst/share/mesos/webui" --work_dir="/tmp/QWYbLV/master" --zk_session_timeout="10secs"
I0527 00:58:51.231639  4696 master.cpp:488] Master only allowing authenticated frameworks to register
I0527 00:58:51.231658  4696 master.cpp:502] Master only allowing authenticated agents to register
I0527 00:58:51.231669  4696 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0527 00:58:51.231683  4696 credentials.hpp:37] Loading credentials for authentication from '/tmp/QWYbLV/credentials'
I0527 00:58:51.232113  4696 master.cpp:560] Using default 'crammd5' authenticator
I0527 00:58:51.232292  4696 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0527 00:58:51.232486  4696 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0527 00:58:51.232659  4696 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0527 00:58:51.232813  4696 master.cpp:640] Authorization enabled
I0527 00:58:51.233059  4691 hierarchical.cpp:158] Initialized hierarchical allocator process
I0527 00:58:51.233106  4684 whitelist_watcher.cpp:77] No whitelist given
I0527 00:58:51.235910  4688 master.cpp:2161] Elected as the leading master!
I0527 00:58:51.235944  4688 master.cpp:1700] Recovering from registrar
I0527 00:58:51.236090  4686 registrar.cpp:345] Recovering registrar
I0527 00:58:51.236887  4686 registrar.cpp:389] Successfully fetched the registry (0B) in 747776ns
I0527 00:58:51.236999  4686 registrar.cpp:493] Applied 1 operations in 26664ns; attempting to update the registry
I0527 00:58:51.237644  4686 registrar.cpp:550] Successfully updated the registry in 588032ns
I0527 00:58:51.237757  4686 registrar.cpp:422] Successfully recovered registrar
I0527 00:58:51.238283  4697 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0527 00:58:51.238273  4691 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0527 00:58:51.244307  4664 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0527 00:58:51.244963  4664 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0527 00:58:51.245087  4664 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0527 00:58:51.245139  4664 provisioner.cpp:255] Using default backend 'copy'
I0527 00:58:51.247324  4664 cluster.cpp:448] Creating default 'local' authorizer
I0527 00:58:51.249347  4697 slave.cpp:232] Mesos agent started on (331)@172.17.0.3:58547
I0527 00:58:51.249408  4697 slave.cpp:233] 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/OneWayPartitionTest_MasterToSlave_SyYBSR/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/OneWayPartitionTest_MasterToSlave_SyYBSR/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/OneWayPartitionTest_MasterToSlave_SyYBSR/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/OneWayPartitionTest_MasterToSlave_SyYBSR" --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/OneWayPartitionTest_MasterToSlave_vVqTOT"
I0527 00:58:51.249945  4697 credentials.hpp:86] Loading credential for authentication from '/tmp/OneWayPartitionTest_MasterToSlave_SyYBSR/credential'
I0527 00:58:51.250131  4697 slave.cpp:265] Agent using credential for: test-principal
I0527 00:58:51.250156  4697 credentials.hpp:37] Loading credentials for authentication from '/tmp/OneWayPartitionTest_MasterToSlave_SyYBSR/http_credentials'
I0527 00:58:51.250473  4697 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0527 00:58:51.250643  4697 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0527 00:58:51.252465  4697 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:58:51.252562  4697 slave.cpp:544] Agent attributes: [  ]
I0527 00:58:51.252578  4697 slave.cpp:549] Agent hostname: 31b7750c93d8
I0527 00:58:51.252791  4683 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:58:51.254622  4695 state.cpp:62] Recovering state from '/tmp/OneWayPartitionTest_MasterToSlave_vVqTOT/meta'
I0527 00:58:51.255033  4694 status_update_manager.cpp:203] Recovering status update manager
I0527 00:58:51.255277  4691 containerizer.cpp:582] Recovering containerizer
I0527 00:58:51.257361  4686 provisioner.cpp:416] Provisioner recovery complete
I0527 00:58:51.257818  4685 slave.cpp:6083] Finished recovery
I0527 00:58:51.258426  4685 slave.cpp:6265] Querying resource estimator for oversubscribable resources
I0527 00:58:51.258760  4693 status_update_manager.cpp:177] Pausing sending status updates
I0527 00:58:51.258755  4685 slave.cpp:929] New master detected at master@172.17.0.3:58547
I0527 00:58:51.258880  4685 slave.cpp:964] Detecting new master
I0527 00:58:51.259089  4685 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator
I0527 00:58:51.263151  4690 slave.cpp:991] Authenticating with master master@172.17.0.3:58547
I0527 00:58:51.263262  4690 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0527 00:58:51.263564  4697 authenticatee.cpp:121] Creating new client SASL connection
I0527 00:58:51.263945  4697 master.cpp:7487] Authenticating slave(331)@172.17.0.3:58547
I0527 00:58:51.264116  4689 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(715)@172.17.0.3:58547
I0527 00:58:51.264456  4698 authenticator.cpp:98] Creating new server SASL connection
I0527 00:58:51.264819  4694 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0527 00:58:51.264856  4694 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0527 00:58:51.265027  4689 authenticator.cpp:204] Received SASL authentication start
I0527 00:58:51.265120  4689 authenticator.cpp:326] Authentication requires more steps
I0527 00:58:51.265307  4695 authenticatee.cpp:259] Received SASL authentication step
I0527 00:58:51.265487  4693 authenticator.cpp:232] Received SASL authentication step
I0527 00:58:51.265528  4693 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '31b7750c93d8' server FQDN: '31b7750c93d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0527 00:58:51.265545  4693 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0527 00:58:51.265596  4693 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0527 00:58:51.265630  4693 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '31b7750c93d8' server FQDN: '31b7750c93d8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0527 00:58:51.265647  4693 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0527 00:58:51.265658  4693 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0527 00:58:51.265681  4693 authenticator.cpp:318] Authentication success
I0527 00:58:51.265810  4685 authenticatee.cpp:299] Authentication success
I0527 00:58:51.265858  4695 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(331)@172.17.0.3:58547
I0527 00:58:51.266001  4696 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(715)@172.17.0.3:58547
I0527 00:58:51.266381  4689 slave.cpp:1086] Successfully authenticated with master master@172.17.0.3:58547
I0527 00:58:51.266633  4689 slave.cpp:1506] Will retry registration in 2.152243ms if necessary
I0527 00:58:51.266832  4694 master.cpp:5429] Received register agent message from slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.266984  4694 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0527 00:58:51.267449  4686 master.cpp:5489] Authorized registration of agent at slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.267619  4686 master.cpp:5568] Registering agent at slave(331)@172.17.0.3:58547 (31b7750c93d8) with id 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0
I0527 00:58:51.268244  4697 registrar.cpp:493] Applied 1 operations in 72680ns; attempting to update the registry
I0527 00:58:51.268993  4697 registrar.cpp:550] Successfully updated the registry in 662016ns
I0527 00:58:51.269376  4685 master.cpp:5615] Admitted agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.269508  4692 slave.cpp:1506] Will retry registration in 32.220838ms if necessary
I0527 00:58:51.270164  4688 slave.cpp:4809] Received ping from slave-observer(337)@172.17.0.3:58547
I0527 00:58:51.270330  4685 master.cpp:5646] Registered agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0527 00:58:51.270619  4691 hierarchical.cpp:525] Added agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 (31b7750c93d8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0527 00:58:51.270648  4688 slave.cpp:1132] Registered with master master@172.17.0.3:58547; given agent ID 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0
I0527 00:58:51.270853  4685 master.cpp:5429] Received register agent message from slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.271066  4685 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0527 00:58:51.271103  4697 status_update_manager.cpp:184] Resuming sending status updates
I0527 00:58:51.271296  4691 hierarchical.cpp:1854] No allocations performed
I0527 00:58:51.271374  4691 hierarchical.cpp:1438] Performed allocation for 1 agents in 272872ns
I0527 00:58:51.271399  4688 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/OneWayPartitionTest_MasterToSlave_vVqTOT/meta/slaves/35bab20d-2bf0-40b0-8b09-2474df0b8013-S0/slave.info'
I0527 00:58:51.271798  4694 master.cpp:1313] Agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8) disconnected
I0527 00:58:51.271826  4688 slave.cpp:1190] Forwarding total oversubscribed resources {}
I0527 00:58:51.271829  4694 master.cpp:3197] Disconnecting agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.271970  4694 master.cpp:3216] Deactivating agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.272148  4698 hierarchical.cpp:653] Agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 deactivated
I0527 00:58:51.272217  4694 master.cpp:5489] Authorized registration of agent at slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.272330  4694 master.cpp:5537] Removing old disconnected agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8) because a registration attempt occurred
I0527 00:58:51.272377  4694 master.cpp:8365] Removing agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8): a new agent registered at the same address
I0527 00:58:51.272639  4694 master.cpp:5568] Registering agent at slave(331)@172.17.0.3:58547 (31b7750c93d8) with id 35bab20d-2bf0-40b0-8b09-2474df0b8013-S1
I0527 00:58:51.272900  4686 registrar.cpp:493] Applied 1 operations in 75888ns; attempting to update the registry
I0527 00:58:51.273020  4694 master.cpp:6336] Received update of agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8) with total oversubscribed resources {}
I0527 00:58:51.274034  4686 registrar.cpp:550] Successfully updated the registry in 0ns
I0527 00:58:51.274226  4690 master.cpp:8407] Removed agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0 at slave(331)@172.17.0.3:58547 (31b7750c93d8): a new agent registered at the same address
I0527 00:58:51.274312  4686 registrar.cpp:493] Applied 1 operations in 53164ns; attempting to update the registry
I0527 00:58:51.275066  4686 registrar.cpp:550] Successfully updated the registry in 0ns
I0527 00:58:51.275125  4685 hierarchical.cpp:558] Removed agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0
I0527 00:58:51.275274  4693 master.cpp:5615] Admitted agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S1 at slave(331)@172.17.0.3:58547 (31b7750c93d8)
I0527 00:58:51.275838  4689 slave.cpp:4809] Received ping from slave-observer(338)@172.17.0.3:58547
I0527 00:58:51.275954  4693 master.cpp:5646] Registered agent 35bab20d-2bf0-40b0-8b09-2474df0b8013-S1 at slave(331)@172.17.0.3:58547 (31b7750c93d8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
E0527 00:58:51.276099  4689 slave.cpp:1172] EXIT with status 1: Registered but got wrong id: 35bab20d-2bf0-40b0-8b09-2474df0b8013-S1 (expected: 35bab20d-2bf0-40b0-8b09-2474df0b8013-S0). Committing suicide

../../3rdparty/libprocess/include/process/gmock.hpp:209: ERROR: this mock object (used in test OneWayPartitionTest.MasterToSlave) should be deleted but never is. Its address is @0x2b69ba706a28.
../../src/tests/mock_registrar.cpp:54: ERROR: this mock object (used in test OneWayPartitionTest.MasterToSlave) should be deleted but never is. Its address is @0x2b69bae56cc0.
ERROR: 2 leaked mock objects found at program exit.
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495843383-13771
Untagged: mesos-1495843383-13771:latest
Deleted: sha256:01e9efab0939900ec5d4fc632f1e8eff4eec052a1e61a7d23ec02baa63ec8070
Deleted: sha256:fb45fb5ff9353397d89537e3ef6679c72135b6de1e83f40e714e2cbd4510bad8
Deleted: sha256:e82f45961992e3632b231619b85878528c1b7e940ea9ba3fb9c282d103f7ec35
Deleted: sha256:31a7f02d9bca63c8a7469834d261c0c53fb398eb631a2f3d7cac9b1aadbf368a
Deleted: sha256:8da00f16e582fea82651df7b9ed1726379ae18f52ab4503c799689ef2134497d
Deleted: sha256:f433aeafd94a2db779add7930286a31d8058e1ee2d915fe2f689328b78fd7b9d
Deleted: sha256:e1e0e7dcfc3656aa18adbe79387c5ab8c98a7651e5e4ea2dcb24824c58149d02
Deleted: sha256:2ffcdb4d10795615c17b8f495ce7b7ae043d572fe5c129ccd1381249158401c0
Deleted: sha256:7a1877741ce74baa250fdefcd6cc03032fa11eb1272c3268144316483d4f56f1
Deleted: sha256:a635ad8b029a86891f02e7544b17b168512cb9e9ff711628b8001285d4db2b9f
Deleted: sha256:270f3b32140266aa8c4ef50c812e8984fe4c59bf029316d1ef59ae331a03c350
Deleted: sha256:bffd8ee5545bbf17bffda4c16c50677efdc04952d6fbbaefa63b9265d485298a
Deleted: sha256:6eb755062e3dc8338e4d7fc4da94a5d8c373951ebc3fd4c3b47d5a757289cc6a
Deleted: sha256:4c9d1fe0945c7401422ca5553c0cb08fe8ebf12c929210f404652052c42a2b82
Deleted: sha256:077b7b55f2be500ff50e29676f9cae2059fb67a4fff79c00855e96375b2e1952
Deleted: sha256:0bd18dd024684d47368ac8b0b3db8ff789ccb1c3c043b6a4daf9645f380606eb
Deleted: sha256:eec1d41f3cf09ac5620640aabec8a7199da91f9d37fe75c20ff66c26ca2fb2fb
Deleted: sha256:0aa2c14d00e93fab267f89ee82d7163632c9a37cf7769e1877cbf12c0b2e1708
Deleted: sha256:388e8ab5b1459723021e3efa3c036d3d0e02ffe22ee60a78934d2b3166fed523
Deleted: sha256:e1bf25840c05c2a65a7bc74f85d4bf03085c0f8bf30855beecc34b84531ff850
Deleted: sha256:03ba9bea829c82c6222d584638f3cf30d78bf5127f593bb78147a298d043878e
Deleted: sha256:cd9e5a2948e20bdbf01d4f09d548c9a28edbc1edb3bf1a841a561b768422a919
Deleted: sha256:dc5295bab334a39a25e9b008fd4e6e783f38c15d9edc27659095ea8258474f8b
Deleted: sha256:dd97829c0eec9e12f43d70feff25bbf516c66426a624ea7f60e58068b050866e
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

Re: Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3732

Posted by Anand Mazumdar <an...@apache.org>.
Looks like the proto3 upgrade made the example python framework unhappy on
the ASF CI.

Zhitao, can you help take a look?

```
[ RUN      ] ExamplesTest.PythonFramework
I0526 23:07:41.294849 12198 exec.cpp:517] Agent exited ... shutting down
Using temporary directory '/tmp/ExamplesTest_PythonFramework_MmAkpb'
Traceback (most recent call last):
  File
"/mesos/mesos-1.4.0/_build/../src/examples/python/test_framework.py", line
24, in &lt;module&gt;
    from mesos.interface import mesos_pb2
  File "build/bdist.linux-x86_64/egg/mesos/interface/mesos_pb2.py", line 7,
in &lt;module&gt;
  File
"/mesos/mesos-1.4.0/_build/3rdparty/protobuf-3.3.0/python/google/protobuf/descriptor.py",
line 37, in &lt;module&gt;
    import six
ImportError: No module named six
../../src/tests/script.cpp:83: Failure
Failed
python_framework_test.sh exited with status 1
```

-anand

On Fri, May 26, 2017 at 4:20 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:

> See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=
> autotools,COMPILER=gcc,CONFIGURATION=--verbose,
> ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,
> label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)
> /3732/display/redirect?page=changes>
>
> Changes:
>
> [neil.conway] Fixed flakiness in MasterTest.EndpointsForHalfRemovedSlave.
>
> ------------------------------------------
> [...truncated 27.43 MB...]
> [       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (30 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
> I0526 23:20:26.470710  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.471159  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.471247  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.471288  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.474050  4678 slave.cpp:232] Mesos agent started on (747)@
> 172.17.0.4:57945
> I0526 23:20:26.474089  4678 slave.cpp:233] 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_MhEs4b/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_2_MhEs4b/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b"
> --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_TbVIcJ"
> I0526 23:20:26.474498  4678 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_2_MhEs4b/credential'
> I0526 23:20:26.474629  4678 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.474650  4678 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> AuthorizedRequest_2_MhEs4b/http_credentials'
> I0526 23:20:26.474889  4678 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.475015  4678 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.476572  4678 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.476670  4678 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.476685  4678 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.476852  4686 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.478298  4689 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_TbVIcJ/meta'
> I0526 23:20:26.478632  4687 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.478829  4685 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.480201  4691 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.480568  4681 slave.cpp:6073] Finished recovery
> I0526 23:20:26.481137  4681 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.481469  4683 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.484195  4689 process.cpp:3730] Handling HTTP event for
> process 'slave(747)' with path: '/slave(747)/containers'
> I0526 23:20:26.485719  4691 http.cpp:1115] HTTP GET for
> /slave(747)/containers from 172.17.0.4:55159
> I0526 23:20:26.485821  4691 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/containers' endpoint
> I0526 23:20:26.489588  4685 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (30 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
> I0526 23:20:26.501230  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.501838  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.501948  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.501987  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.505703  4676 slave.cpp:232] Mesos agent started on (748)@
> 172.17.0.4:57945
> I0526 23:20:26.505736 4676 slave.cpp:233] 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_gzFXN3/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_0_gzFXN3/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3"
> --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_xYciRA"
> I0526 23:20:26.506263  4676 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_0_gzFXN3/credential'
> I0526 23:20:26.506443  4676 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.506479  4676 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_0_gzFXN3/http_credentials'
> I0526 23:20:26.506814  4676 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.507105  4676 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.508307  4676 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.508375  4676 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.508394  4676 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.508523  4679 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.509521  4685 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xYciRA/meta'
> I0526 23:20:26.509763  4684 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.509997  4684 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.511360  4677 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.511720  4684 slave.cpp:6073] Finished recovery
> I0526 23:20:26.512179  4684 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.512451  4688 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.515295  4681 process.cpp:3730] Handling HTTP event for
> process 'slave(748)' with path: '/slave(748)/monitor/statistics'
> I0526 23:20:26.516306  4680 http.cpp:1115] HTTP GET for
> /slave(748)/monitor/statistics from 172.17.0.4:55160
> I0526 23:20:26.516371 4680 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics' endpoint
> I0526 23:20:26.518354  4682 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (28 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
> I0526 23:20:26.529979  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.530529  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.530622  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.530663  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.533524  4688 slave.cpp:232] Mesos agent started on (749)@
> 172.17.0.4:57945
> I0526 23:20:26.533548 4688 slave.cpp:233] 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_WX1xQV/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_1_WX1xQV/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV"
> --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_jTycPs"
> I0526 23:20:26.534073  4688 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_1_WX1xQV/credential'
> I0526 23:20:26.534304  4688 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.534332  4688 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_1_WX1xQV/http_credentials'
> I0526 23:20:26.534632  4688 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.534785  4688 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.535964  4688 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.536032  4688 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.536044  4688 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.536185  4676 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.537197  4681 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_jTycPs/meta'
> I0526 23:20:26.537441  4680 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.537664  4682 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.538960  4683 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.539309  4684 slave.cpp:6073] Finished recovery
> I0526 23:20:26.539748  4684 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.539989  4682 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.543372  4690 process.cpp:3730] Handling HTTP event for
> process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
> I0526 23:20:26.544657  4678 http.cpp:1115] HTTP GET for
> /slave(749)/monitor/statistics.json from 172.17.0.4:55161
> I0526 23:20:26.544719 4678 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics.json' endpoint
> I0526 23:20:26.547142  4681 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (28 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
> I0526 23:20:26.557791  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.558295  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.558383  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.558423  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.561491  4677 slave.cpp:232] Mesos agent started on (750)@
> 172.17.0.4:57945
> I0526 23:20:26.561517 4677 slave.cpp:233] 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_aCIwbO/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_2_aCIwbO/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO"
> --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_Tvwy5k"
> I0526 23:20:26.562029  4677 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_2_aCIwbO/credential'
> I0526 23:20:26.562258  4677 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.562286  4677 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> UnauthorizedRequest_2_aCIwbO/http_credentials'
> I0526 23:20:26.562602  4677 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.562757  4677 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.563941  4677 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.564013  4677 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.564025  4677 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.564152  4689 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.565357  4689 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Tvwy5k/meta'
> I0526 23:20:26.565721  4676 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.565951  4691 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.567447  4688 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.567822  4676 slave.cpp:6073] Finished recovery
> I0526 23:20:26.568315  4676 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.568536  4682 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.571760  4678 process.cpp:3730] Handling HTTP event for
> process 'slave(750)' with path: '/slave(750)/containers'
> I0526 23:20:26.573423  4684 http.cpp:1115] HTTP GET for
> /slave(750)/containers from 172.17.0.4:55162
> I0526 23:20:26.573536 4684 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/containers' endpoint
> I0526 23:20:26.575860  4686 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (28 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
> I0526 23:20:26.586117  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.586604  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.586694  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.586733  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.588413  4657 cluster.cpp:448] Creating default 'local'
> authorizer
> I0526 23:20:26.590008  4690 slave.cpp:232] Mesos agent started on (751)@
> 172.17.0.4:57945
> I0526 23:20:26.590032  4690 slave.cpp:233] 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_QgdROG/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_0_QgdROG/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG"
> --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_VGhkEd"
> I0526 23:20:26.590584  4690 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_0_QgdROG/credential'
> I0526 23:20:26.590741  4690 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.590767  4690 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_0_QgdROG/http_credentials'
> I0526 23:20:26.591050  4690 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.591193  4690 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.592869  4690 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.592960  4690 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.592975  4690 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.593165  4676 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.594841  4686 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_VGhkEd/meta'
> I0526 23:20:26.595242  4690 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.595477  4681 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.597064  4685 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.597476  4687 slave.cpp:6073] Finished recovery
> I0526 23:20:26.598114  4687 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.598443  4684 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.601523  4681 process.cpp:3730] Handling HTTP event for
> process 'slave(751)' with path: '/slave(751)/monitor/statistics'
> I0526 23:20:26.603164  4691 http.cpp:1115] HTTP GET for
> /slave(751)/monitor/statistics from 172.17.0.4:55163
> I0526 23:20:26.603284 4691 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics' endpoint
> I0526 23:20:26.607534  4688 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (32 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
> I0526 23:20:26.618181  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.618682  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.618777  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.618808  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.620955  4657 cluster.cpp:448] Creating default 'local'
> authorizer
> I0526 23:20:26.622992  4678 slave.cpp:232] Mesos agent started on (752)@
> 172.17.0.4:57945
> I0526 23:20:26.623014  4678 slave.cpp:233] 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_XV6DMz/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_1_XV6DMz/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz"
> --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_IPDTw6"
> I0526 23:20:26.623383  4678 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_1_XV6DMz/credential'
> I0526 23:20:26.623585  4678 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.623605  4678 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_1_XV6DMz/http_credentials'
> I0526 23:20:26.623834  4678 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.623971  4678 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.625248  4678 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.625314  4678 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.625325  4678 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.625478  4681 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.626879  4682 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_IPDTw6/meta'
> I0526 23:20:26.627312  4687 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.627600  4682 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.628826  4676 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.629151  4684 slave.cpp:6073] Finished recovery
> I0526 23:20:26.629590  4684 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.629829  4688 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.632310  4683 process.cpp:3730] Handling HTTP event for
> process 'slave(752)' with path: '/slave(752)/monitor/statistics.json'
> I0526 23:20:26.633327  4691 http.cpp:1115] HTTP GET for
> /slave(752)/monitor/statistics.json from 172.17.0.4:55164
> I0526 23:20:26.633381  4691 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/monitor/statistics.json' endpoint
> I0526 23:20:26.637092  4685 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (28 ms)
> [ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
> I0526 23:20:26.647064  4657 containerizer.cpp:230] Using isolation:
> posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
> W0526 23:20:26.647747  4657 backend.cpp:76] Failed to create 'aufs'
> backend: AufsBackend requires root privileges
> W0526 23:20:26.647878  4657 backend.cpp:76] Failed to create 'bind'
> backend: BindBackend requires root privileges
> I0526 23:20:26.647931  4657 provisioner.cpp:255] Using default backend
> 'copy'
> I0526 23:20:26.649971  4657 cluster.cpp:448] Creating default 'local'
> authorizer
> I0526 23:20:26.651473  4680 slave.cpp:232] Mesos agent started on (753)@
> 172.17.0.4:57945
> I0526 23:20:26.651509  4680 slave.cpp:233] 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_vTuz3s/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_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_2_vTuz3s/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src"
> --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns"
> --quiet="false" --recover="reconnect" --recovery_timeout="15mins"
> --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;
> mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true"
> --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s"
> --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_es49IZ"
> I0526 23:20:26.651933  4680 credentials.hpp:86] Loading credential for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_2_vTuz3s/credential'
> I0526 23:20:26.652150  4680 slave.cpp:265] Agent using credential for:
> test-principal
> I0526 23:20:26.652169  4680 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/Endpoint_SlaveEndpointTest_
> NoAuthorizer_2_vTuz3s/http_credentials'
> I0526 23:20:26.652400  4680 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0526 23:20:26.652539  4680 http.cpp:975] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0526 23:20:26.653745  4680 slave.cpp:536] Agent resources: cpus(*):2;
> mem(*):1024; disk(*):1024; ports(*):[31000-32000]
> I0526 23:20:26.653811  4680 slave.cpp:544] Agent attributes: [  ]
> I0526 23:20:26.653822  4680 slave.cpp:549] Agent hostname: 76935d675c78
> I0526 23:20:26.653945  4685 status_update_manager.cpp:177] Pausing sending
> status updates
> I0526 23:20:26.655215  4684 state.cpp:62] Recovering state from
> '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_es49IZ/meta'
> I0526 23:20:26.655719  4685 status_update_manager.cpp:203] Recovering
> status update manager
> I0526 23:20:26.655942  4691 containerizer.cpp:582] Recovering containerizer
> I0526 23:20:26.657331  4687 provisioner.cpp:416] Provisioner recovery
> complete
> I0526 23:20:26.657726  4690 slave.cpp:6073] Finished recovery
> I0526 23:20:26.658275  4690 slave.cpp:6255] Querying resource estimator
> for oversubscribable resources
> I0526 23:20:26.658535  4683 slave.cpp:6269] Received oversubscribable
> resources {} from the resource estimator
> I0526 23:20:26.660908  4677 process.cpp:3730] Handling HTTP event for
> process 'slave(753)' with path: '/slave(753)/containers'
> I0526 23:20:26.662113  4689 http.cpp:1115] HTTP GET for
> /slave(753)/containers from 172.17.0.4:55165
> I0526 23:20:26.662180  4689 http.cpp:936] Authorizing principal
> 'test-principal' to GET the '/containers' endpoint
> I0526 23:20:26.666144  4677 slave.cpp:801] Agent terminating
> [       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (30 ms)
> [----------] 9 tests from Endpoint/SlaveEndpointTest (269 ms total)
>
> [----------] Global test environment tear-down
> [==========] 1580 tests from 176 test cases ran. (574673 ms total)
> [  PASSED  ] 1579 tests.
> [  FAILED  ] 1 test, listed below:
> [  FAILED  ] ExamplesTest.PythonFramework
>
>  1 FAILED TEST
>   YOU HAVE 22 DISABLED TESTS
>
> E0526 23:20:26.725785  4692 process.cpp:950] Failed to accept socket:
> future discarded
> make[4]: *** [check-local] Error 1
> make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
> make[3]: *** [check-am] Error 2
> make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
> make[2]: *** [check] Error 2
> make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
> make[1]: *** [check-recursive] Error 1
> make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
> make: *** [distcheck] Error 1
> + docker rmi mesos-1495837141-8553
> Untagged: mesos-1495837141-8553:latest
> Deleted: sha256:bdd8bdf15f698abdbb7bfe24471d0d
> 676747086fac4b9f744eeb6766a02baca4
> Deleted: sha256:cd3f6fb9cd9802a1ad38c3d27862b9
> 033e673c26135b14388d2a4e7e4b19a6b9
> Deleted: sha256:37c59b3c98eb1212a7d3f292d2dc8e
> 8d4bf51dc1fdb1f6ca4c1de19c5f5dc2e1
> Deleted: sha256:682b99dafaec314371eb5652a1a710
> 7e853438ab1dcdd57b781dd79f7ca7f02b
> Deleted: sha256:5bba71321c9ba3f4a354ca06585005
> 518ffc843cd4f54e06027fdf573fca3bba
> Deleted: sha256:0dca9dd9d9d676b482b8bc77b85e78
> 381f029a077114cf60f971adf93bc9b16b
> Deleted: sha256:5eaad18716319f571bbad0a480f182
> 7e2a0c9a4584d19b29f7d2019e3d05694e
> Deleted: sha256:e8467038090626891885b4922ffdf5
> 1b59b6351edbbc4711149b749aeb391bef
> Deleted: sha256:aa4714c544fb8d2ea67a4b59798b04
> 3f27ff46abf5597c8dbe3960c11525a138
> Deleted: sha256:9be1a73a4a2e2070948d304de4baa3
> 422ee1c4dfd10e9c3386e4c0469d426c28
> Deleted: sha256:dd7ac281e9d1b5445bd1c750c2f9b2
> 9e87921796ad5a28217c79abad91dcda28
> Deleted: sha256:32adc626051cd3c94cf78dcdc46cb9
> bb1a85db03fc8fb54c2c51f923728594b0
> Deleted: sha256:49d7e4d53ca19c1aacc136557ace27
> e019af5cba250e13e451441f680f0d036a
> Deleted: sha256:34b40492cc801fd59835ca02333c5f
> aabce7f5c7f1c00d37713f11b18e1e1894
> Deleted: sha256:8d1d7442694de83ae7b64d1eedf26b
> c8bb8e0bc2a3f87ad5c2b90f4cac5c46d7
> Deleted: sha256:7218bfc854864b169967be1bff2599
> 58a931d95331470f2f3ede84096fd62a92
> Deleted: sha256:ce57023a0f2b056139a189c44e673d
> 857a2fb4337a563d80d3a8523e380e9344
> Deleted: sha256:cf131314bc6ffb51f5ee449becff94
> a289c70b7cbad2c2c6d7e973c093b10d20
> Deleted: sha256:efe0142a9ac935b6f4deed4d243b11
> d062943980a74ea4ca608dd66f2e88a7f7
> Deleted: sha256:2ca1ac59ff4967d1d842f5a3b54287
> 507110b54d25dc7ae3b9a3897d7da056b8
> Deleted: sha256:b42bdd570e48fa9747ffe1b9f9d812
> f7e3eebe7646a2f49e99cd8c743c2a661d
> Deleted: sha256:3de92aae642695b87fd71ae3104055
> 477d59138efa20c31a3fec57676c719f44
> Deleted: sha256:ec0fbdeb592ee96b1757548ccf6107
> cb52d09a3e538ce5e08db7a5b864966f55
> Deleted: sha256:647fd033649ae607a18576fdd34f3a
> ad496afc56b15468bd7ef3ee5f3d191275
> Build step 'Execute shell' marked build as failure
> Not sending mail to unregistered user neil.conway@gmail.com
>

Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3732

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

Changes:

[neil.conway] Fixed flakiness in MasterTest.EndpointsForHalfRemovedSlave.

------------------------------------------
[...truncated 27.43 MB...]
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0526 23:20:26.470710  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.471159  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.471247  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.471288  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.474050  4678 slave.cpp:232] Mesos agent started on (747)@172.17.0.4:57945
I0526 23:20:26.474089  4678 slave.cpp:233] 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_MhEs4b/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b" --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_TbVIcJ"
I0526 23:20:26.474498  4678 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b/credential'
I0526 23:20:26.474629  4678 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.474650  4678 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_MhEs4b/http_credentials'
I0526 23:20:26.474889  4678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.475015  4678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.476572  4678 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.476670  4678 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.476685  4678 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.476852  4686 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.478298  4689 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_TbVIcJ/meta'
I0526 23:20:26.478632  4687 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.478829  4685 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.480201  4691 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.480568  4681 slave.cpp:6073] Finished recovery
I0526 23:20:26.481137  4681 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.481469  4683 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.484195  4689 process.cpp:3730] Handling HTTP event for process 'slave(747)' with path: '/slave(747)/containers'
I0526 23:20:26.485719  4691 http.cpp:1115] HTTP GET for /slave(747)/containers from 172.17.0.4:55159
I0526 23:20:26.485821  4691 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 23:20:26.489588  4685 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (30 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0526 23:20:26.501230  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.501838  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.501948  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.501987  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.505703  4676 slave.cpp:232] Mesos agent started on (748)@172.17.0.4:57945
I0526 23:20:26.505736  4676 slave.cpp:233] 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_gzFXN3/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3" --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_xYciRA"
I0526 23:20:26.506263  4676 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3/credential'
I0526 23:20:26.506443  4676 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.506479  4676 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_gzFXN3/http_credentials'
I0526 23:20:26.506814  4676 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.507105  4676 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.508307  4676 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.508375  4676 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.508394  4676 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.508523  4679 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.509521  4685 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_xYciRA/meta'
I0526 23:20:26.509763  4684 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.509997  4684 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.511360  4677 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.511720  4684 slave.cpp:6073] Finished recovery
I0526 23:20:26.512179  4684 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.512451  4688 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.515295  4681 process.cpp:3730] Handling HTTP event for process 'slave(748)' with path: '/slave(748)/monitor/statistics'
I0526 23:20:26.516306  4680 http.cpp:1115] HTTP GET for /slave(748)/monitor/statistics from 172.17.0.4:55160
I0526 23:20:26.516371  4680 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 23:20:26.518354  4682 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (28 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0526 23:20:26.529979  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.530529  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.530622  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.530663  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.533524  4688 slave.cpp:232] Mesos agent started on (749)@172.17.0.4:57945
I0526 23:20:26.533548  4688 slave.cpp:233] 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_WX1xQV/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV" --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_jTycPs"
I0526 23:20:26.534073  4688 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV/credential'
I0526 23:20:26.534304  4688 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.534332  4688 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_WX1xQV/http_credentials'
I0526 23:20:26.534632  4688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.534785  4688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.535964  4688 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.536032  4688 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.536044  4688 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.536185  4676 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.537197  4681 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_jTycPs/meta'
I0526 23:20:26.537441  4680 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.537664  4682 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.538960  4683 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.539309  4684 slave.cpp:6073] Finished recovery
I0526 23:20:26.539748  4684 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.539989  4682 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.543372  4690 process.cpp:3730] Handling HTTP event for process 'slave(749)' with path: '/slave(749)/monitor/statistics.json'
I0526 23:20:26.544657  4678 http.cpp:1115] HTTP GET for /slave(749)/monitor/statistics.json from 172.17.0.4:55161
I0526 23:20:26.544719  4678 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 23:20:26.547142  4681 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (28 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0526 23:20:26.557791  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.558295  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.558383  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.558423  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.561491  4677 slave.cpp:232] Mesos agent started on (750)@172.17.0.4:57945
I0526 23:20:26.561517  4677 slave.cpp:233] 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_aCIwbO/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO" --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_Tvwy5k"
I0526 23:20:26.562029  4677 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO/credential'
I0526 23:20:26.562258  4677 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.562286  4677 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_aCIwbO/http_credentials'
I0526 23:20:26.562602  4677 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.562757  4677 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.563941  4677 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.564013  4677 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.564025  4677 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.564152  4689 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.565357  4689 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Tvwy5k/meta'
I0526 23:20:26.565721  4676 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.565951  4691 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.567447  4688 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.567822  4676 slave.cpp:6073] Finished recovery
I0526 23:20:26.568315  4676 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.568536  4682 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.571760  4678 process.cpp:3730] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/containers'
I0526 23:20:26.573423  4684 http.cpp:1115] HTTP GET for /slave(750)/containers from 172.17.0.4:55162
I0526 23:20:26.573536  4684 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 23:20:26.575860  4686 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (28 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0526 23:20:26.586117  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.586604  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.586694  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.586733  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.588413  4657 cluster.cpp:448] Creating default 'local' authorizer
I0526 23:20:26.590008  4690 slave.cpp:232] Mesos agent started on (751)@172.17.0.4:57945
I0526 23:20:26.590032  4690 slave.cpp:233] 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_QgdROG/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG" --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_VGhkEd"
I0526 23:20:26.590584  4690 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG/credential'
I0526 23:20:26.590741  4690 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.590767  4690 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_QgdROG/http_credentials'
I0526 23:20:26.591050  4690 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.591193  4690 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.592869  4690 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.592960  4690 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.592975  4690 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.593165  4676 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.594841  4686 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_VGhkEd/meta'
I0526 23:20:26.595242  4690 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.595477  4681 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.597064  4685 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.597476  4687 slave.cpp:6073] Finished recovery
I0526 23:20:26.598114  4687 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.598443  4684 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.601523  4681 process.cpp:3730] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/monitor/statistics'
I0526 23:20:26.603164  4691 http.cpp:1115] HTTP GET for /slave(751)/monitor/statistics from 172.17.0.4:55163
I0526 23:20:26.603284  4691 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0526 23:20:26.607534  4688 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (32 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0526 23:20:26.618181  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.618682  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.618777  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.618808  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.620955  4657 cluster.cpp:448] Creating default 'local' authorizer
I0526 23:20:26.622992  4678 slave.cpp:232] Mesos agent started on (752)@172.17.0.4:57945
I0526 23:20:26.623014  4678 slave.cpp:233] 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_XV6DMz/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz" --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_IPDTw6"
I0526 23:20:26.623383  4678 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz/credential'
I0526 23:20:26.623585  4678 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.623605  4678 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_XV6DMz/http_credentials'
I0526 23:20:26.623834  4678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.623971  4678 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.625248  4678 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.625314  4678 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.625325  4678 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.625478  4681 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.626879  4682 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_IPDTw6/meta'
I0526 23:20:26.627312  4687 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.627600  4682 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.628826  4676 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.629151  4684 slave.cpp:6073] Finished recovery
I0526 23:20:26.629590  4684 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.629829  4688 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.632310  4683 process.cpp:3730] Handling HTTP event for process 'slave(752)' with path: '/slave(752)/monitor/statistics.json'
I0526 23:20:26.633327  4691 http.cpp:1115] HTTP GET for /slave(752)/monitor/statistics.json from 172.17.0.4:55164
I0526 23:20:26.633381  4691 http.cpp:936] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0526 23:20:26.637092  4685 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (28 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0526 23:20:26.647064  4657 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0526 23:20:26.647747  4657 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0526 23:20:26.647878  4657 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0526 23:20:26.647931  4657 provisioner.cpp:255] Using default backend 'copy'
I0526 23:20:26.649971  4657 cluster.cpp:448] Creating default 'local' authorizer
I0526 23:20:26.651473  4680 slave.cpp:232] Mesos agent started on (753)@172.17.0.4:57945
I0526 23:20:26.651509  4680 slave.cpp:233] 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_vTuz3s/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_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s" --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_es49IZ"
I0526 23:20:26.651933  4680 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s/credential'
I0526 23:20:26.652150  4680 slave.cpp:265] Agent using credential for: test-principal
I0526 23:20:26.652169  4680 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_vTuz3s/http_credentials'
I0526 23:20:26.652400  4680 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0526 23:20:26.652539  4680 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0526 23:20:26.653745  4680 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0526 23:20:26.653811  4680 slave.cpp:544] Agent attributes: [  ]
I0526 23:20:26.653822  4680 slave.cpp:549] Agent hostname: 76935d675c78
I0526 23:20:26.653945  4685 status_update_manager.cpp:177] Pausing sending status updates
I0526 23:20:26.655215  4684 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_es49IZ/meta'
I0526 23:20:26.655719  4685 status_update_manager.cpp:203] Recovering status update manager
I0526 23:20:26.655942  4691 containerizer.cpp:582] Recovering containerizer
I0526 23:20:26.657331  4687 provisioner.cpp:416] Provisioner recovery complete
I0526 23:20:26.657726  4690 slave.cpp:6073] Finished recovery
I0526 23:20:26.658275  4690 slave.cpp:6255] Querying resource estimator for oversubscribable resources
I0526 23:20:26.658535  4683 slave.cpp:6269] Received oversubscribable resources {} from the resource estimator
I0526 23:20:26.660908  4677 process.cpp:3730] Handling HTTP event for process 'slave(753)' with path: '/slave(753)/containers'
I0526 23:20:26.662113  4689 http.cpp:1115] HTTP GET for /slave(753)/containers from 172.17.0.4:55165
I0526 23:20:26.662180  4689 http.cpp:936] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0526 23:20:26.666144  4677 slave.cpp:801] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (30 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (269 ms total)

[----------] Global test environment tear-down
[==========] 1580 tests from 176 test cases ran. (574673 ms total)
[  PASSED  ] 1579 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ExamplesTest.PythonFramework

 1 FAILED TEST
  YOU HAVE 22 DISABLED TESTS

E0526 23:20:26.725785  4692 process.cpp:950] Failed to accept socket: future discarded
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.4.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1495837141-8553
Untagged: mesos-1495837141-8553:latest
Deleted: sha256:bdd8bdf15f698abdbb7bfe24471d0d676747086fac4b9f744eeb6766a02baca4
Deleted: sha256:cd3f6fb9cd9802a1ad38c3d27862b9033e673c26135b14388d2a4e7e4b19a6b9
Deleted: sha256:37c59b3c98eb1212a7d3f292d2dc8e8d4bf51dc1fdb1f6ca4c1de19c5f5dc2e1
Deleted: sha256:682b99dafaec314371eb5652a1a7107e853438ab1dcdd57b781dd79f7ca7f02b
Deleted: sha256:5bba71321c9ba3f4a354ca06585005518ffc843cd4f54e06027fdf573fca3bba
Deleted: sha256:0dca9dd9d9d676b482b8bc77b85e78381f029a077114cf60f971adf93bc9b16b
Deleted: sha256:5eaad18716319f571bbad0a480f1827e2a0c9a4584d19b29f7d2019e3d05694e
Deleted: sha256:e8467038090626891885b4922ffdf51b59b6351edbbc4711149b749aeb391bef
Deleted: sha256:aa4714c544fb8d2ea67a4b59798b043f27ff46abf5597c8dbe3960c11525a138
Deleted: sha256:9be1a73a4a2e2070948d304de4baa3422ee1c4dfd10e9c3386e4c0469d426c28
Deleted: sha256:dd7ac281e9d1b5445bd1c750c2f9b29e87921796ad5a28217c79abad91dcda28
Deleted: sha256:32adc626051cd3c94cf78dcdc46cb9bb1a85db03fc8fb54c2c51f923728594b0
Deleted: sha256:49d7e4d53ca19c1aacc136557ace27e019af5cba250e13e451441f680f0d036a
Deleted: sha256:34b40492cc801fd59835ca02333c5faabce7f5c7f1c00d37713f11b18e1e1894
Deleted: sha256:8d1d7442694de83ae7b64d1eedf26bc8bb8e0bc2a3f87ad5c2b90f4cac5c46d7
Deleted: sha256:7218bfc854864b169967be1bff259958a931d95331470f2f3ede84096fd62a92
Deleted: sha256:ce57023a0f2b056139a189c44e673d857a2fb4337a563d80d3a8523e380e9344
Deleted: sha256:cf131314bc6ffb51f5ee449becff94a289c70b7cbad2c2c6d7e973c093b10d20
Deleted: sha256:efe0142a9ac935b6f4deed4d243b11d062943980a74ea4ca608dd66f2e88a7f7
Deleted: sha256:2ca1ac59ff4967d1d842f5a3b54287507110b54d25dc7ae3b9a3897d7da056b8
Deleted: sha256:b42bdd570e48fa9747ffe1b9f9d812f7e3eebe7646a2f49e99cd8c743c2a661d
Deleted: sha256:3de92aae642695b87fd71ae3104055477d59138efa20c31a3fec57676c719f44
Deleted: sha256:ec0fbdeb592ee96b1757548ccf6107cb52d09a3e538ce5e08db7a5b864966f55
Deleted: sha256:647fd033649ae607a18576fdd34f3aad496afc56b15468bd7ef3ee5f3d191275
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com