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/02/25 00:26:12 UTC

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

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

Changes:

[bmahler] Added allocation role validation for Reserve operation.

[bmahler] Added allocation role validation for Create operation.

[bmahler] Cleaned up an error message formatting.

------------------------------------------
[...truncated 23.98 MB...]
I0225 00:26:07.080988 24840 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.081862 24836 process.cpp:3704] Handling HTTP event for process 'slave(701)' with path: '/slave(701)/monitor/statistics.json'
I0225 00:26:07.082417 24838 http.cpp:885] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0225 00:26:07.084161 24841 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (13 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0225 00:26:07.089922 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.090279 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.090324 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.090337 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.091584 24830 slave.cpp:211] Mesos agent started on (702)@172.17.0.2:58896
I0225 00:26:07.091621 24830 slave.cpp:212] 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_dV2Oa2/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_dV2Oa2/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_dV2Oa2/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_dV2Oa2" --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_JFwtWa"
I0225 00:26:07.092079 24830 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_dV2Oa2/credential'
I0225 00:26:07.092214 24830 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.092237 24830 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_dV2Oa2/http_credentials'
I0225 00:26:07.092386 24830 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.092453 24830 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.092988 24830 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.093032 24830 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.093039 24830 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.093165 24832 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.093482 24843 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_JFwtWa/meta'
I0225 00:26:07.093755 24837 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.093906 24841 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.094542 24840 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.094708 24830 slave.cpp:5559] Finished recovery
I0225 00:26:07.095088 24830 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.095193 24842 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.096235 24841 process.cpp:3704] Handling HTTP event for process 'slave(702)' with path: '/slave(702)/containers'
I0225 00:26:07.096706 24838 http.cpp:885] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0225 00:26:07.098297 24839 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (13 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0225 00:26:07.103761 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.104135 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.104176 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.104188 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.105362 24829 slave.cpp:211] Mesos agent started on (703)@172.17.0.2:58896
I0225 00:26:07.105393 24829 slave.cpp:212] 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_lT7Ldt/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_lT7Ldt/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_lT7Ldt/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_lT7Ldt" --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_VAObXB"
I0225 00:26:07.105801 24829 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_lT7Ldt/credential'
I0225 00:26:07.105919 24829 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.105938 24829 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_lT7Ldt/http_credentials'
I0225 00:26:07.106065 24829 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.106122 24829 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.106606 24829 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.106647 24829 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.106657 24829 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.106741 24844 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.107033 24837 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_VAObXB/meta'
I0225 00:26:07.107175 24829 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.107285 24829 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.107929 24839 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.108121 24836 slave.cpp:5559] Finished recovery
I0225 00:26:07.108564 24836 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.108719 24843 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.109537 24839 process.cpp:3704] Handling HTTP event for process 'slave(703)' with path: '/slave(703)/monitor/statistics'
I0225 00:26:07.110054 24829 http.cpp:885] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0225 00:26:07.111374 24843 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (13 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0225 00:26:07.117949 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.118382 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.118427 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.118445 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.119812 24835 slave.cpp:211] Mesos agent started on (704)@172.17.0.2:58896
I0225 00:26:07.119841 24835 slave.cpp:212] 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_BlkApU/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BlkApU/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BlkApU/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_BlkApU" --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_RGSL62"
I0225 00:26:07.120321 24835 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BlkApU/credential'
I0225 00:26:07.120417 24835 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.120432 24835 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_BlkApU/http_credentials'
I0225 00:26:07.120543 24835 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.120592 24835 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.121067 24835 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.121110 24835 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.121122 24835 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.121227 24836 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.121680 24843 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_RGSL62/meta'
I0225 00:26:07.121836 24831 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.122174 24835 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.122915 24837 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.123241 24834 slave.cpp:5559] Finished recovery
I0225 00:26:07.123674 24834 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.123821 24838 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.124650 24835 process.cpp:3704] Handling HTTP event for process 'slave(704)' with path: '/slave(704)/monitor/statistics.json'
I0225 00:26:07.125116 24838 http.cpp:885] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0225 00:26:07.126497 24828 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (15 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0225 00:26:07.132206 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.132452 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.132499 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.132519 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.133635 24843 slave.cpp:211] Mesos agent started on (705)@172.17.0.2:58896
I0225 00:26:07.133656 24843 slave.cpp:212] 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_vtNXKl/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vtNXKl/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vtNXKl/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_vtNXKl" --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_xJLMpu"
I0225 00:26:07.134063 24843 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vtNXKl/credential'
I0225 00:26:07.134196 24843 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.134220 24843 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_vtNXKl/http_credentials'
I0225 00:26:07.134357 24843 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.134428 24843 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.134927 24843 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.134968 24843 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.134975 24843 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.135047 24834 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.135519 24843 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_xJLMpu/meta'
I0225 00:26:07.135809 24844 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.135946 24835 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.136718 24832 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.137006 24830 slave.cpp:5559] Finished recovery
I0225 00:26:07.137634 24830 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.137836 24829 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.138763 24840 process.cpp:3704] Handling HTTP event for process 'slave(705)' with path: '/slave(705)/containers'
I0225 00:26:07.139394 24834 http.cpp:885] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0225 00:26:07.140472 24834 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (14 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0225 00:26:07.146143 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.146420 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.146459 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.146472 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.147243 24828 cluster.cpp:446] Creating default 'local' authorizer
I0225 00:26:07.147917 24833 slave.cpp:211] Mesos agent started on (706)@172.17.0.2:58896
I0225 00:26:07.148039 24833 slave.cpp:212] 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_LIXtfN/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LIXtfN/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LIXtfN/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_LIXtfN" --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_9OR0RV"
I0225 00:26:07.148481 24833 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LIXtfN/credential'
I0225 00:26:07.148584 24833 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.148600 24833 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LIXtfN/http_credentials'
I0225 00:26:07.148712 24833 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.148764 24833 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.149266 24833 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.149307 24833 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.149317 24833 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.149406 24839 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.149790 24833 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_9OR0RV/meta'
I0225 00:26:07.149956 24836 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.150209 24837 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.150750 24833 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.150910 24835 slave.cpp:5559] Finished recovery
I0225 00:26:07.151250 24835 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.151372 24830 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.152055 24839 process.cpp:3704] Handling HTTP event for process 'slave(706)' with path: '/slave(706)/monitor/statistics'
I0225 00:26:07.152565 24844 http.cpp:885] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0225 00:26:07.156918 24833 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (16 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0225 00:26:07.161962 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.162231 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.162279 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.162346 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.163090 24828 cluster.cpp:446] Creating default 'local' authorizer
I0225 00:26:07.163658 24831 slave.cpp:211] Mesos agent started on (707)@172.17.0.2:58896
I0225 00:26:07.163688 24831 slave.cpp:212] 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_1qc0Te/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1qc0Te/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1qc0Te/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_1qc0Te" --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_llIWtn"
I0225 00:26:07.164162 24831 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1qc0Te/credential'
I0225 00:26:07.164263 24831 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.164279 24831 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1qc0Te/http_credentials'
I0225 00:26:07.164422 24831 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.164505 24831 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.165030 24831 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.165071 24831 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.165079 24831 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.165149 24829 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.165508 24830 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_llIWtn/meta'
I0225 00:26:07.165650 24831 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.165801 24840 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.166455 24843 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.166676 24844 slave.cpp:5559] Finished recovery
I0225 00:26:07.167110 24844 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.167237 24838 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.168001 24831 process.cpp:3704] Handling HTTP event for process 'slave(707)' with path: '/slave(707)/monitor/statistics.json'
I0225 00:26:07.168493 24844 http.cpp:885] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0225 00:26:07.169790 24844 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (12 ms)
[ RUN      ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0225 00:26:07.174120 24828 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0225 00:26:07.174353 24828 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0225 00:26:07.174387 24828 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0225 00:26:07.174399 24828 provisioner.cpp:249] Using default backend 'copy'
I0225 00:26:07.174808 24828 cluster.cpp:446] Creating default 'local' authorizer
I0225 00:26:07.175266 24830 slave.cpp:211] Mesos agent started on (708)@172.17.0.2:58896
I0225 00:26:07.175292 24830 slave.cpp:212] 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_bVf5GG/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bVf5GG/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bVf5GG/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_bVf5GG" --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_Xy61eP"
I0225 00:26:07.175587 24830 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bVf5GG/credential'
I0225 00:26:07.175664 24830 slave.cpp:354] Agent using credential for: test-principal
I0225 00:26:07.175675 24830 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_bVf5GG/http_credentials'
I0225 00:26:07.175762 24830 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0225 00:26:07.175809 24830 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0225 00:26:07.176161 24830 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0225 00:26:07.176192 24830 slave.cpp:549] Agent attributes: [  ]
I0225 00:26:07.176198 24830 slave.cpp:554] Agent hostname: 9833678d1292
I0225 00:26:07.176251 24836 status_update_manager.cpp:177] Pausing sending status updates
I0225 00:26:07.176661 24838 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_Xy61eP/meta'
I0225 00:26:07.176820 24833 status_update_manager.cpp:203] Recovering status update manager
I0225 00:26:07.176959 24841 containerizer.cpp:599] Recovering containerizer
I0225 00:26:07.177505 24829 provisioner.cpp:410] Provisioner recovery complete
I0225 00:26:07.177755 24837 slave.cpp:5559] Finished recovery
I0225 00:26:07.178184 24837 slave.cpp:5733] Querying resource estimator for oversubscribable resources
I0225 00:26:07.178267 24839 slave.cpp:5747] Received oversubscribable resources {} from the resource estimator
I0225 00:26:07.179006 24832 process.cpp:3704] Handling HTTP event for process 'slave(708)' with path: '/slave(708)/containers'
I0225 00:26:07.179425 24829 http.cpp:885] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0225 00:26:07.180853 24838 slave.cpp:803] Agent terminating
[       OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (11 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (126 ms total)

[----------] Global test environment tear-down
/mesos/src/tests/environment.cpp:836: Failure
Failed
Tests completed with child processes remaining:
-+- 24828 src/mesos-tests 
 \-+- 28596 /mesos/build/src/mesos-containerizer launch 
   \--- 28597 mesos-executor --launcher_dir=/mesos/build/src 
[==========] 1461 tests from 161 test cases ran. (204610 ms total)
[  PASSED  ] 1460 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] MesosContainerizerSlaveRecoveryTest.ResourceStatistics

 1 FAILED TEST
  YOU HAVE 12 DISABLED TESTS

I0225 00:26:07.257133 28606 exec.cpp:488] Agent exited, but framework has checkpointing enabled. Waiting 15mins to reconnect with agent 2506274a-0983-4c8c-8469-a49cb3c5d75e-S0
make[3]: *** [CMakeFiles/check] Error 1
make[3]: Leaving directory `/mesos/build'
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1487980353-16549
Untagged: mesos-1487980353-16549:latest
Deleted: sha256:aacbf864ce09a17fa3098bdf761c35f1c534591d2408d608fd288305c203e491
Deleted: sha256:3c0cb9ec970e22622ab10c55968b5256ee5b09a541d15b0532bab943b82af403
Deleted: sha256:d4ab436f7e7b3359fba2d30eb832433c657f8f00a5c7aa7f8a0df849bd974a48
Deleted: sha256:1b0de621e584b9ccaa441434057ffe77a68983afaf34075bcc43ea58394e9da0
Deleted: sha256:3fd034073028b801c710571bd8587edd0ee9b54d37854299a49c3467cbe85d44
Deleted: sha256:610c0279de6773cda0c8583eaf82c76998fb7979b9ba6a3e5e2bd5eea3985a07
Deleted: sha256:7a14a8576fd538ec1966dae53a89ba3c793a3342161199aae697787b17fb8e17
Deleted: sha256:7a74270e99fc1f617f521cb106779cd8ea9e05e70bc5ef0f2f05c341d7919d01
Deleted: sha256:583d45f259cd40e41079a01cdee3d8dde7e362c968db598afd5f4bd53fc7be9e
Deleted: sha256:00419bb8997195bd9bcb45c5cd9f45b888adedd6d5d97c1f35d10b9c3b11cbda
Deleted: sha256:fb34dc2bf2f8cee0badee76ddfb99c231106822485c87ab73078d555d1dca006
Deleted: sha256:14df60e5a1153c4ad58ed1866f01306159245357f6cc50f8ec661655a5b2f641
Deleted: sha256:e9c05cf809ae64f6b0c3380273b8095106c24411fdeae15b84384d2d612e0e1e
Deleted: sha256:886dad0d8cfc77fd3e9c4caa02fd262699d4302e516b187d419bbf6dbc24a595
Deleted: sha256:83504bd9d7aff60e35ce1727158392f555383ef411a3c8e64408fa0a86590dc9
Deleted: sha256:73ee041d34d51751ee1408b2f0dfa1fa17b064bd70c7307756ce4e7bdc88c93c
Deleted: sha256:7d2ea46595e3e26cbfadfee12e6f1a53187af00b6f1d3d9aa89f3206a4c8c26b
Deleted: sha256:a8fb437654f5119ed98568cd7bef9d939552055770679b69872ab9a442f48501
Deleted: sha256:575b2fa16178b548242b752d2b412671b26f2d2d02e804d9262e8c13556b44b5
Deleted: sha256:fac56e4aca2ee8d978549e4b0362744cb37fd05c76a1004ce073f611801a0f14
Deleted: sha256:10269b241a1db03d8262925bf3c0027a82b44156413174fb288506c08123053d
Deleted: sha256:e24986d6555be3d1d0d7749b0dd31769977a9e9ba61c11c5f9b28141c9a3fda7
Deleted: sha256:5e85ba979e3777e39974795c9a0eadb0e6505851266e556db39b2b20f0e09749
Deleted: sha256:2a8cad364a0b53cd1a9bace1ec1da399284805a626ee86243b294cbbdc8a922a
Build step 'Execute shell' marked build as failure

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

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