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/01 15:27:12 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3205
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3205/changes>
Changes:
[alexr] Fixed a typo in "scheduler.proto".
[alexr] Augmented comments around (health) check delay in "mesos.proto".
------------------------------------------
[...truncated 173580 lines...]
I0201 15:27:04.036068 31209 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.037945 31199 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.038424 31202 slave.cpp:5422] Finished recovery
I0201 15:27:04.039093 31202 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.039494 31206 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.042919 31201 process.cpp:3697] Handling HTTP event for process 'slave(681)' with path: '/slave(681)/monitor/statistics.json'
I0201 15:27:04.044400 31213 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0201 15:27:04.048323 31210 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (38 ms)
[ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0201 15:27:04.061604 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.062290 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.062417 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.062469 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.066191 31211 slave.cpp:209] Mesos agent started on (682)@172.17.0.4:50740
I0201 15:27:04.066331 31211 slave.cpp:210] 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_haG3fV/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_haG3fV/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_haG3fV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_haG3fV" --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_v0KlHa"
I0201 15:27:04.067281 31211 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_haG3fV/credential'
I0201 15:27:04.067515 31211 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.067550 31211 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_haG3fV/http_credentials'
I0201 15:27:04.067950 31211 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.068131 31211 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.069767 31211 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.069872 31211 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.069890 31211 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.070055 31210 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.071750 31212 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_v0KlHa/meta'
I0201 15:27:04.072119 31211 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.072340 31205 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.074156 31198 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.074707 31210 slave.cpp:5422] Finished recovery
I0201 15:27:04.075378 31210 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.075711 31198 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.078908 31209 process.cpp:3697] Handling HTTP event for process 'slave(682)' with path: '/slave(682)/containers'
I0201 15:27:04.080425 31199 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0201 15:27:04.085757 31200 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (35 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0201 15:27:04.098445 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.099097 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.099243 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.099295 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.103257 31202 slave.cpp:209] Mesos agent started on (683)@172.17.0.4:50740
I0201 15:27:04.103296 31202 slave.cpp:210] 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_sn7WOV/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_sn7WOV/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_sn7WOV/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_sn7WOV" --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_PIeiab"
I0201 15:27:04.104328 31202 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_sn7WOV/credential'
I0201 15:27:04.104619 31202 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.104658 31202 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_sn7WOV/http_credentials'
I0201 15:27:04.105087 31202 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.105307 31202 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.106935 31202 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.107038 31202 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.107050 31202 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.108816 31209 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_PIeiab/meta'
I0201 15:27:04.108822 31202 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.109174 31201 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.109448 31207 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.111985 31205 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.112468 31202 slave.cpp:5422] Finished recovery
I0201 15:27:04.113013 31202 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.113370 31205 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.116608 31205 process.cpp:3697] Handling HTTP event for process 'slave(683)' with path: '/slave(683)/monitor/statistics'
I0201 15:27:04.118104 31211 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0201 15:27:04.120726 31199 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (33 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0201 15:27:04.131984 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.132649 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.132769 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.132820 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.136428 31208 slave.cpp:209] Mesos agent started on (684)@172.17.0.4:50740
I0201 15:27:04.136462 31208 slave.cpp:210] 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_qxirKW/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_qxirKW/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_qxirKW/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qxirKW" --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_pPTi0b"
I0201 15:27:04.137291 31208 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qxirKW/credential'
I0201 15:27:04.137476 31208 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.137501 31208 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_qxirKW/http_credentials'
I0201 15:27:04.137810 31208 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.138010 31208 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.139775 31208 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.139881 31208 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.139899 31208 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.140069 31213 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.141670 31201 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_pPTi0b/meta'
I0201 15:27:04.142014 31203 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.142271 31203 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.143796 31207 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.144171 31211 slave.cpp:5422] Finished recovery
I0201 15:27:04.145205 31211 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.145637 31211 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.148919 31203 process.cpp:3697] Handling HTTP event for process 'slave(684)' with path: '/slave(684)/monitor/statistics.json'
I0201 15:27:04.150773 31203 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0201 15:27:04.153470 31213 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (32 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0201 15:27:04.164510 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.165089 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.165184 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.165215 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.167943 31205 slave.cpp:209] Mesos agent started on (685)@172.17.0.4:50740
I0201 15:27:04.167969 31205 slave.cpp:210] 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_1kG20X/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_1kG20X/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_1kG20X/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_1kG20X" --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_k3bCbd"
I0201 15:27:04.168464 31205 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_1kG20X/credential'
I0201 15:27:04.168696 31205 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.168720 31205 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_1kG20X/http_credentials'
I0201 15:27:04.168956 31205 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.169111 31205 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.170382 31205 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.170466 31205 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.170485 31205 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.170691 31210 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.172159 31204 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_k3bCbd/meta'
I0201 15:27:04.172446 31210 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.172672 31199 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.174036 31201 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.174468 31210 slave.cpp:5422] Finished recovery
I0201 15:27:04.175040 31210 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.175318 31209 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.178079 31212 process.cpp:3697] Handling HTTP event for process 'slave(685)' with path: '/slave(685)/containers'
I0201 15:27:04.179865 31203 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0201 15:27:04.182461 31203 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (29 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0201 15:27:04.195034 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.195682 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.195816 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.195909 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.197865 31179 cluster.cpp:446] Creating default 'local' authorizer
I0201 15:27:04.200124 31204 slave.cpp:209] Mesos agent started on (686)@172.17.0.4:50740
I0201 15:27:04.200157 31204 slave.cpp:210] 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_LFpbBZ/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_LFpbBZ/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_LFpbBZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LFpbBZ" --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_Fg1QGe"
I0201 15:27:04.201339 31204 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LFpbBZ/credential'
I0201 15:27:04.201648 31204 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.201678 31204 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_LFpbBZ/http_credentials'
I0201 15:27:04.201988 31204 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.202169 31204 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.203848 31204 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.203960 31204 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.203975 31204 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.204171 31212 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.206131 31202 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Fg1QGe/meta'
I0201 15:27:04.206511 31199 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.206738 31203 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.208451 31199 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.209137 31199 slave.cpp:5422] Finished recovery
I0201 15:27:04.209712 31199 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.210472 31199 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.213737 31201 process.cpp:3697] Handling HTTP event for process 'slave(686)' with path: '/slave(686)/monitor/statistics'
I0201 15:27:04.215400 31198 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0201 15:27:04.219485 31200 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (36 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0201 15:27:04.231894 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.232578 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.232723 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.232779 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.234673 31179 cluster.cpp:446] Creating default 'local' authorizer
I0201 15:27:04.236704 31210 slave.cpp:209] Mesos agent started on (687)@172.17.0.4:50740
I0201 15:27:04.236879 31210 slave.cpp:210] 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_1xCSy1/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_1xCSy1/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_1xCSy1/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1xCSy1" --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_MfGzyg"
I0201 15:27:04.237416 31210 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1xCSy1/credential'
I0201 15:27:04.237573 31210 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.237597 31210 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_1xCSy1/http_credentials'
I0201 15:27:04.237826 31210 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.238004 31210 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.239378 31210 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.239492 31210 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.239521 31210 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.239714 31208 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.241366 31198 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_MfGzyg/meta'
I0201 15:27:04.241760 31203 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.242014 31210 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.243451 31208 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.243846 31213 slave.cpp:5422] Finished recovery
I0201 15:27:04.244536 31213 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.244802 31213 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.247447 31200 process.cpp:3697] Handling HTTP event for process 'slave(687)' with path: '/slave(687)/monitor/statistics.json'
I0201 15:27:04.248904 31200 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0201 15:27:04.253036 31208 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (33 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0201 15:27:04.263821 31179 containerizer.cpp:220] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0201 15:27:04.264307 31179 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0201 15:27:04.264441 31179 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0201 15:27:04.264482 31179 provisioner.cpp:249] Using default backend 'copy'
I0201 15:27:04.265977 31179 cluster.cpp:446] Creating default 'local' authorizer
I0201 15:27:04.267946 31211 slave.cpp:209] Mesos agent started on (688)@172.17.0.4:50740
I0201 15:27:04.268076 31211 slave.cpp:210] 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_mUR2R3/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_mUR2R3/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_mUR2R3/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_mUR2R3" --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_eGhtMi"
I0201 15:27:04.268735 31211 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_mUR2R3/credential'
I0201 15:27:04.268888 31211 slave.cpp:352] Agent using credential for: test-principal
I0201 15:27:04.268913 31211 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_mUR2R3/http_credentials'
I0201 15:27:04.269160 31211 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 15:27:04.269320 31211 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 15:27:04.270814 31211 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 15:27:04.270916 31211 slave.cpp:547] Agent attributes: [ ]
I0201 15:27:04.270941 31211 slave.cpp:552] Agent hostname: 139bddb8ac44
I0201 15:27:04.271100 31203 status_update_manager.cpp:177] Pausing sending status updates
I0201 15:27:04.272652 31212 state.cpp:60] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_eGhtMi/meta'
I0201 15:27:04.273192 31213 status_update_manager.cpp:203] Recovering status update manager
I0201 15:27:04.273440 31212 containerizer.cpp:599] Recovering containerizer
I0201 15:27:04.275158 31209 provisioner.cpp:410] Provisioner recovery complete
I0201 15:27:04.275604 31210 slave.cpp:5422] Finished recovery
I0201 15:27:04.276242 31210 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 15:27:04.276582 31205 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 15:27:04.280210 31199 process.cpp:3697] Handling HTTP event for process 'slave(688)' with path: '/slave(688)/containers'
I0201 15:27:04.281752 31213 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0201 15:27:04.285537 31209 slave.cpp:801] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (33 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (311 ms total)
[----------] Global test environment tear-down
[==========] 1459 tests from 165 test cases ran. (421849 ms total)
[ PASSED ] 1458 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] IOSwitchboardTest.RecoverThenKillSwitchboardContainerDestroyed
1 FAILED TEST
YOU HAVE 14 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1485960008-1521
Untagged: mesos-1485960008-1521:latest
Deleted: sha256:ffdea718be5f36a93c3c2a1d1541907b43e74b86c01652f90ebc80016142ec91
Deleted: sha256:14b9d822f391c1f6e0f54f68071373545ce2d2b098aa2f92cc2c27e0a6c76a84
Deleted: sha256:9d605eba5bf3449adcc211c2b003fcc459d694fce4914992b483e8a8026074f9
Deleted: sha256:5efe98bf2c29b9dad4d5e7932bbe06414ee27230d1a7879d7e7267ce7141437b
Deleted: sha256:1e31366258a8347be472834004cdc7f9ccaea013300641b8eea016d7deca3a53
Deleted: sha256:197d74faf45bf12fbea93ef2e8571b62a9896faf9d87fce8f02adad4b557e0f1
Deleted: sha256:d443db55c5a762774837d21b18adda82ad68bac0c76d75497aac1f4b2e346185
Deleted: sha256:919d7d868bd6a118692892bae8bebc7bc739960cc1691eb233dc39db3905b9bf
Deleted: sha256:bc902336917c0aa98300b694dcc13b631786c491d90cb70d1d265d437cc5c9e5
Deleted: sha256:7afbcb013a7ad37d173ac2cbf6f490552fbd49db536914f5d9f0b6bb2fd359e2
Deleted: sha256:d290be552f552f7b468a96435d06fa50857051a7c5e82d20159cd516fbde2151
Deleted: sha256:22e585f857999cea044d76cbbcaf65958f0906e1adb6785fda283ede8f693075
Deleted: sha256:807c138ba2b54eef1a6ebcad4cdf33480ca3007bdc04d55859385a94fafd2629
Deleted: sha256:008d4a2c2f7bdf983f6ed36df7a88f06e83d5bab6e76fb08b14e8f113ff300d8
Deleted: sha256:16aac04199d302cd0dbe65078efffa1713df546e2b20714dae1bd27aa489436a
Deleted: sha256:40b30af494d953fddf13ef0ed56c9529fd95fcee91ade01030681d07f8e6a7b7
Deleted: sha256:24fe55d9fb3d60172356b5cf71923f8261fe4ca512b7882ea5d3ef8f604cb221
Deleted: sha256:76d1c138ba8a5e99132268ea78847d6cf43379a2442580b4fad956e76f510b3e
Deleted: sha256:2d92b55a441b4d89b6dadd92dccde2f7ed4d99ba4a5d0fab1bd513d4d097cb2e
Deleted: sha256:f1d5f942f5e4b9481c1efffe61c42bdc6401be05d2496ca178f01684e2ae3456
Deleted: sha256:f9fe8a6c016fdf4cf2cf48f95b1f6d8c02fda179bfe5eacf04c5b34516437569
Deleted: sha256:f007b94c37406dd592fccb92ca283e7406daa37320a228cd91d2bce7e95557a0
Deleted: sha256:237eb45b58ff5d85e4104611c24a9b37901243409cc2c8d374d71159b091a97b
Deleted: sha256:ebafbc8e433f01fde7aea9cb49847ea5f921d5f3ed383ef024bdbe2ebd9a4365
Deleted: sha256:cd191b8412fbae8e016fcb50915d9d9fd83c2bd138bd018409530f11f47967af
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,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3207
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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3207/changes>
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3206
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=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3206/changes>
Changes:
[alexr] Fixed minor formatting issue in "scheduler.proto".
[alexr] Updated reconciliation comment in "scheduler.proto".
[vinodkone] Removed inactive Athens, Greece MUG from communities.
------------------------------------------
[...truncated 44052 lines...]
I0201 20:32:52.052284 31207 master.cpp:8157] Updating the state of task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0201 20:32:52.059612 31203 scheduler.cpp:676] Enqueuing event ERROR received from http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.064761 31205 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.069967 31205 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:52781/master/api/v1/scheduler
E0201 20:32:52.071962 31209 scheduler.cpp:649] End-Of-File received from master. The master closed the event stream
I0201 20:32:52.072441 31209 scheduler.cpp:444] Re-detecting master
I0201 20:32:52.077437 31201 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0201 20:32:52.085348 31197 scheduler.cpp:395] Ignoring disconnection attempt from stale connection
I0201 20:32:52.085803 31206 scheduler.cpp:470] New master detected at master@172.17.0.3:52781
I0201 20:32:52.085842 31206 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0201 20:32:52.115953 31206 hierarchical.cpp:1675] No allocations performed
I0201 20:32:52.116037 31206 hierarchical.cpp:1770] No inverse offers to send out!
I0201 20:32:52.116127 31206 hierarchical.cpp:1279] Performed allocation for 1 agents in 365925ns
I0201 20:32:52.116297 31203 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:52781/master/api/v1/scheduler
W0201 20:32:52.117918 31202 status_update_manager.cpp:478] Resending status update TASK_RUNNING (UUID: f573f36a-e0da-418a-bde1-a41c0b8b53fb) for task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.117985 31202 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: f573f36a-e0da-418a-bde1-a41c0b8b53fb) for task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 to the agent
I0201 20:32:52.119981 31210 slave.cpp:4196] Forwarding the update TASK_RUNNING (UUID: f573f36a-e0da-418a-bde1-a41c0b8b53fb) for task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 to master@172.17.0.3:52781
I0201 20:32:52.120589 31208 master.cpp:6021] Status update TASK_RUNNING (UUID: f573f36a-e0da-418a-bde1-a41c0b8b53fb) for task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 from agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.120669 31208 master.cpp:6089] Forwarding status update TASK_RUNNING (UUID: f573f36a-e0da-418a-bde1-a41c0b8b53fb) for task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.121167 31208 master.cpp:8157] Updating the state of task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0201 20:32:52.125031 31202 scheduler.cpp:361] Connected with the master at http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.147147 31202 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.177615 31197 master.cpp:1380] Framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (default) disconnected
I0201 20:32:52.177678 31197 master.cpp:3080] Deactivating framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (default)
I0201 20:32:52.177754 31197 master.cpp:3057] Disconnecting framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (default)
I0201 20:32:52.177795 31197 master.cpp:1395] Giving framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (default) 0ns to failover
I0201 20:32:52.178069 31197 hierarchical.cpp:386] Deactivated framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.189090 31197 master.cpp:6699] Framework failover timeout, removing framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (default)
I0201 20:32:52.189155 31197 master.cpp:7572] Removing framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (default)
I0201 20:32:52.189355 31209 slave.cpp:2598] Asked to shut down framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 by master@172.17.0.3:52781
I0201 20:32:52.189410 31209 slave.cpp:2623] Shutting down framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.189394 31197 master.cpp:8157] Updating the state of task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0201 20:32:52.189472 31209 slave.cpp:5005] Shutting down executor 'default' of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (via HTTP)
I0201 20:32:52.190358 31197 master.cpp:8251] Removing task 53d33d2b-04d0-4b4e-878e-a7a341770419 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 on agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.190785 31197 master.cpp:8280] Removing executor 'default' with resources {} of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 on agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.190985 31196 hierarchical.cpp:1011] Recovered cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 from framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.191319 31197 hierarchical.cpp:337] Removed framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.209786 31208 executor.cpp:716] Enqueuing event SHUTDOWN received from http://172.17.0.3:52781/slave(86)/api/v1/executor
I0201 20:32:52.223166 31198 slave.cpp:4691] Executor 'default' of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 exited with status 0
I0201 20:32:52.223326 31198 slave.cpp:4791] Cleaning up executor 'default' of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 (via HTTP)
I0201 20:32:52.223776 31198 slave.cpp:4879] Cleaning up framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
W0201 20:32:52.224480 31198 master.cpp:6145] Ignoring unknown exited executor 'default' of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000 on agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.224556 31198 gc.cpp:55] Scheduling '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_ifNuoF/slaves/054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0/frameworks/054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000/executors/default/runs/c8082fc0-4337-4ae2-a31c-31aa66e06bb6' for gc 6.99999899166519days in the future
I0201 20:32:52.224728 31198 gc.cpp:55] Scheduling '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_ifNuoF/slaves/054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0/frameworks/054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000/executors/default' for gc 6.99999899166519days in the future
I0201 20:32:52.224818 31198 gc.cpp:55] Scheduling '/tmp/HttpFaultToleranceTest_SchedulerFailoverStatusUpdate_ifNuoF/slaves/054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0/frameworks/054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000' for gc 6.99999899166519days in the future
I0201 20:32:52.224916 31198 status_update_manager.cpp:285] Closing status update streams for framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.224977 31198 status_update_manager.cpp:531] Cleaning up status update stream for task 53d33d2b-04d0-4b4e-878e-a7a341770419 of framework 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-0000
I0201 20:32:52.233368 31202 slave.cpp:801] Agent terminating
I0201 20:32:52.249392 31203 master.cpp:1263] Agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c) disconnected
I0201 20:32:52.249466 31203 master.cpp:3117] Disconnecting agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.249641 31203 master.cpp:3136] Deactivating agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 at slave(86)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.249923 31203 hierarchical.cpp:577] Agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0 deactivated
I0201 20:32:52.286782 31177 master.cpp:1102] Master terminating
I0201 20:32:52.290047 31198 hierarchical.cpp:510] Removed agent 054bad4f-2e08-467a-8dba-3ff5d4a1e9bb-S0
[ OK ] HttpFaultToleranceTest.SchedulerFailoverStatusUpdate (542 ms)
[ RUN ] HttpFaultToleranceTest.SchedulerFailoverExecutorToFrameworkMessage
I0201 20:32:52.327695 31177 cluster.cpp:160] Creating default 'local' authorizer
I0201 20:32:52.335459 31196 master.cpp:383] Master 8ae838c1-8359-4144-b231-0277c048bb56 (74011da6cc0c) started on 172.17.0.3:52781
I0201 20:32:52.335839 31196 master.cpp:385] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="false" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/wzsDZn/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" --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.2.0/_inst/share/mesos/webui" --work_dir="/tmp/wzsDZn/master" --zk_session_timeout="10secs"
I0201 20:32:52.337359 31196 master.cpp:437] Master allowing unauthenticated frameworks to register
I0201 20:32:52.337538 31196 master.cpp:449] Master only allowing authenticated agents to register
I0201 20:32:52.337692 31196 master.cpp:462] Master only allowing authenticated HTTP frameworks to register
I0201 20:32:52.337853 31196 credentials.hpp:37] Loading credentials for authentication from '/tmp/wzsDZn/credentials'
I0201 20:32:52.338425 31196 master.cpp:507] Using default 'crammd5' authenticator
I0201 20:32:52.338868 31196 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0201 20:32:52.339458 31196 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0201 20:32:52.339965 31196 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0201 20:32:52.340766 31196 master.cpp:587] Authorization enabled
I0201 20:32:52.341210 31207 hierarchical.cpp:151] Initialized hierarchical allocator process
I0201 20:32:52.341542 31206 whitelist_watcher.cpp:77] No whitelist given
I0201 20:32:52.350541 31196 master.cpp:2123] Elected as the leading master!
I0201 20:32:52.350838 31196 master.cpp:1645] Recovering from registrar
I0201 20:32:52.351207 31206 registrar.cpp:329] Recovering registrar
I0201 20:32:52.352730 31206 registrar.cpp:362] Successfully fetched the registry (0B) in 1.32992ms
I0201 20:32:52.353029 31206 registrar.cpp:461] Applied 1 operations in 25453ns; attempting to update the registry
I0201 20:32:52.354655 31206 registrar.cpp:506] Successfully updated the registry in 1.416704ms
I0201 20:32:52.354986 31206 registrar.cpp:392] Successfully recovered registrar
I0201 20:32:52.365463 31207 hierarchical.cpp:178] Skipping recovery of hierarchical allocator: nothing to recover
I0201 20:32:52.365825 31196 master.cpp:1761] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0201 20:32:52.372879 31177 cluster.cpp:446] Creating default 'local' authorizer
I0201 20:32:52.383798 31200 slave.cpp:209] Mesos agent started on (87)@172.17.0.3:52781
I0201 20:32:52.384147 31200 slave.cpp:210] 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/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_hNFBih/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/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_hNFBih/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/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_hNFBih/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_hNFBih" --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/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_D8z6Dk"
I0201 20:32:52.385224 31200 credentials.hpp:86] Loading credential for authentication from '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_hNFBih/credential'
I0201 20:32:52.385607 31200 slave.cpp:352] Agent using credential for: test-principal
I0201 20:32:52.385784 31200 credentials.hpp:37] Loading credentials for authentication from '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_hNFBih/http_credentials'
I0201 20:32:52.386293 31200 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0201 20:32:52.386631 31200 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0201 20:32:52.388723 31200 slave.cpp:539] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 20:32:52.389204 31200 slave.cpp:547] Agent attributes: [ ]
I0201 20:32:52.389363 31200 slave.cpp:552] Agent hostname: 74011da6cc0c
I0201 20:32:52.391719 31200 status_update_manager.cpp:177] Pausing sending status updates
I0201 20:32:52.392859 31206 state.cpp:60] Recovering state from '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_D8z6Dk/meta'
I0201 20:32:52.393878 31200 status_update_manager.cpp:203] Recovering status update manager
I0201 20:32:52.394752 31210 slave.cpp:5422] Finished recovery
I0201 20:32:52.395506 31210 slave.cpp:5596] Querying resource estimator for oversubscribable resources
I0201 20:32:52.396164 31210 slave.cpp:929] New master detected at master@172.17.0.3:52781
I0201 20:32:52.396698 31210 slave.cpp:964] Detecting new master
I0201 20:32:52.397073 31210 slave.cpp:5610] Received oversubscribable resources {} from the resource estimator
I0201 20:32:52.397649 31200 status_update_manager.cpp:177] Pausing sending status updates
I0201 20:32:52.399227 31177 scheduler.cpp:184] Version: 1.2.0
I0201 20:32:52.400087 31196 scheduler.cpp:470] New master detected at master@172.17.0.3:52781
I0201 20:32:52.400336 31196 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0201 20:32:52.406505 31206 slave.cpp:991] Authenticating with master master@172.17.0.3:52781
I0201 20:32:52.407184 31206 slave.cpp:1002] Using default CRAM-MD5 authenticatee
I0201 20:32:52.407675 31206 authenticatee.cpp:121] Creating new client SASL connection
I0201 20:32:52.408228 31206 master.cpp:7018] Authenticating slave(87)@172.17.0.3:52781
I0201 20:32:52.408640 31206 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(210)@172.17.0.3:52781
I0201 20:32:52.409255 31206 authenticator.cpp:98] Creating new server SASL connection
I0201 20:32:52.409922 31206 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0201 20:32:52.410192 31206 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0201 20:32:52.410459 31206 authenticator.cpp:204] Received SASL authentication start
I0201 20:32:52.410740 31206 authenticator.cpp:326] Authentication requires more steps
I0201 20:32:52.411027 31206 authenticatee.cpp:259] Received SASL authentication step
I0201 20:32:52.411368 31206 authenticator.cpp:232] Received SASL authentication step
I0201 20:32:52.411620 31206 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '74011da6cc0c' server FQDN: '74011da6cc0c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0201 20:32:52.411798 31206 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0201 20:32:52.412004 31206 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0201 20:32:52.412192 31206 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '74011da6cc0c' server FQDN: '74011da6cc0c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0201 20:32:52.412360 31206 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0201 20:32:52.412531 31206 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0201 20:32:52.412710 31206 authenticator.cpp:318] Authentication success
I0201 20:32:52.406744 31207 scheduler.cpp:361] Connected with the master at http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.413100 31199 master.cpp:7048] Successfully authenticated principal 'test-principal' at slave(87)@172.17.0.3:52781
I0201 20:32:52.413025 31198 authenticatee.cpp:299] Authentication success
I0201 20:32:52.413950 31198 slave.cpp:1086] Successfully authenticated with master master@172.17.0.3:52781
I0201 20:32:52.414136 31206 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(210)@172.17.0.3:52781
I0201 20:32:52.414665 31198 slave.cpp:1508] Will retry registration in 11.232069ms if necessary
I0201 20:32:52.415066 31198 master.cpp:5303] Registering agent at slave(87)@172.17.0.3:52781 (74011da6cc0c) with id 8ae838c1-8359-4144-b231-0277c048bb56-S0
I0201 20:32:52.415762 31198 registrar.cpp:461] Applied 1 operations in 79014ns; attempting to update the registry
I0201 20:32:52.418208 31198 registrar.cpp:506] Successfully updated the registry in 2.356224ms
I0201 20:32:52.419469 31198 master.cpp:5377] Registered agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 at slave(87)@172.17.0.3:52781 (74011da6cc0c) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0201 20:32:52.419893 31205 slave.cpp:1132] Registered with master master@172.17.0.3:52781; given agent ID 8ae838c1-8359-4144-b231-0277c048bb56-S0
I0201 20:32:52.419924 31205 fetcher.cpp:90] Clearing fetcher cache
I0201 20:32:52.420426 31205 slave.cpp:1160] Checkpointing SlaveInfo to '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_D8z6Dk/meta/slaves/8ae838c1-8359-4144-b231-0277c048bb56-S0/slave.info'
I0201 20:32:52.420701 31201 status_update_manager.cpp:184] Resuming sending status updates
I0201 20:32:52.421083 31205 slave.cpp:1198] Forwarding total oversubscribed resources {}
I0201 20:32:52.421206 31205 slave.cpp:4286] Received ping from slave-observer(82)@172.17.0.3:52781
I0201 20:32:52.421478 31205 master.cpp:5876] Received update of agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 at slave(87)@172.17.0.3:52781 (74011da6cc0c) with total oversubscribed resources {}
I0201 20:32:52.422123 31198 hierarchical.cpp:478] Added agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 (74011da6cc0c) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0201 20:32:52.422343 31198 hierarchical.cpp:1675] No allocations performed
I0201 20:32:52.422422 31198 hierarchical.cpp:1302] Performed allocation for agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 in 243414ns
I0201 20:32:52.422605 31198 hierarchical.cpp:548] Agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 (74011da6cc0c) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {})
I0201 20:32:52.422780 31198 hierarchical.cpp:1675] No allocations performed
I0201 20:32:52.422847 31198 hierarchical.cpp:1302] Performed allocation for agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 in 191524ns
I0201 20:32:52.423457 31201 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.431196 31197 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0201 20:32:52.433414 31197 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:59308
I0201 20:32:52.433699 31197 master.cpp:2422] Received subscription request for HTTP framework 'default'
I0201 20:32:52.433799 31197 master.cpp:2159] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0201 20:32:52.434847 31197 master.cpp:2536] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0201 20:32:52.435931 31197 hierarchical.cpp:271] Added framework 8ae838c1-8359-4144-b231-0277c048bb56-0000
I0201 20:32:52.437327 31203 master.hpp:2114] Sending heartbeat to 8ae838c1-8359-4144-b231-0277c048bb56-0000
I0201 20:32:52.441138 31210 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.442201 31210 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.444331 31197 hierarchical.cpp:1770] No inverse offers to send out!
I0201 20:32:52.444442 31197 hierarchical.cpp:1279] Performed allocation for 1 agents in 8.474586ms
I0201 20:32:52.445196 31197 master.cpp:6847] Sending 1 offers to framework 8ae838c1-8359-4144-b231-0277c048bb56-0000 (default)
I0201 20:32:52.448065 31204 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.474999 31196 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:52781/master/api/v1/scheduler
I0201 20:32:52.478488 31196 process.cpp:3697] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0201 20:32:52.480670 31196 http.cpp:420] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:59307
I0201 20:32:52.481958 31196 master.cpp:3730] Processing ACCEPT call for offers: [ 8ae838c1-8359-4144-b231-0277c048bb56-O0 ] on agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 at slave(87)@172.17.0.3:52781 (74011da6cc0c) for framework 8ae838c1-8359-4144-b231-0277c048bb56-0000 (default)
I0201 20:32:52.482084 31196 master.cpp:3318] Authorizing framework principal 'test-principal' to launch task 94110b31-1134-4f11-afab-924548b51fe7
W0201 20:32:52.486312 31200 validation.cpp:1018] Executor 'default' for task '94110b31-1134-4f11-afab-924548b51fe7' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0201 20:32:52.486376 31200 validation.cpp:1030] Executor 'default' for task '94110b31-1134-4f11-afab-924548b51fe7' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0201 20:32:52.487130 31200 master.cpp:8902] Adding task 94110b31-1134-4f11-afab-924548b51fe7 with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 at slave(87)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.487604 31200 master.cpp:4380] Launching task 94110b31-1134-4f11-afab-924548b51fe7 of framework 8ae838c1-8359-4144-b231-0277c048bb56-0000 (default) with resources cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] on agent 8ae838c1-8359-4144-b231-0277c048bb56-S0 at slave(87)@172.17.0.3:52781 (74011da6cc0c)
I0201 20:32:52.488579 31200 slave.cpp:1576] Got assigned task '94110b31-1134-4f11-afab-924548b51fe7' for framework 8ae838c1-8359-4144-b231-0277c048bb56-0000
I0201 20:32:52.489547 31200 slave.cpp:1736] Launching task '94110b31-1134-4f11-afab-924548b51fe7' for framework 8ae838c1-8359-4144-b231-0277c048bb56-0000
I0201 20:32:52.490476 31200 paths.cpp:547] Trying to chown '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_D8z6Dk/slaves/8ae838c1-8359-4144-b231-0277c048bb56-S0/frameworks/8ae838c1-8359-4144-b231-0277c048bb56-0000/executors/default/runs/07d4317f-93ec-40f2-9086-6a6b5f5ab6ca' to user 'mesos'
I0201 20:32:52.490795 31200 slave.cpp:6331] Launching executor 'default' of framework 8ae838c1-8359-4144-b231-0277c048bb56-0000 with resources {} in work directory '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_D8z6Dk/slaves/8ae838c1-8359-4144-b231-0277c048bb56-S0/frameworks/8ae838c1-8359-4144-b231-0277c048bb56-0000/executors/default/runs/07d4317f-93ec-40f2-9086-6a6b5f5ab6ca'
I0201 20:32:52.491629 31200 slave.cpp:2058] Queued task '94110b31-1134-4f11-afab-924548b51fe7' for executor 'default' of framework 8ae838c1-8359-4144-b231-0277c048bb56-0000
I0201 20:32:52.491715 31200 slave.cpp:882] Successfully attached file '/tmp/HttpFaultToleranceTest_SchedulerFailoverExecutorToFrameworkMessage_D8z6Dk/slaves/8ae838c1-8359-4144-b231-0277c048bb56-S0/frameworks/8ae838c1-8359-4144-b231-0277c048bb56-0000/executors/default/runs/07d4317f-93ec-40f2-9086-6a6b5f5ab6ca'
I0201 20:32:52.494812 31200 executor.cpp:192] Version: 1.2.0
I0201 20:32:52.498898 31198 executor.cpp:401] Connected with the agent
I0201 20:32:52.500072 31198 executor.cpp:302] Sending SUBSCRIBE call to http://172.17.0.3:52781/slave(87)/api/v1/executor
I0201 20:32:52.503176 31198 process.cpp:3697] Handling HTTP event for process 'slave(87)' with path: '/slave(87)/api/v1/executor'
I0201 20:32:52.505043 31198 http.cpp:303] HTTP POST for /slave(87)/api/v1/executor from 172.17.0.3:59309
I0201 20:32:52.505499 31198 slave.cpp:3109] Received Subscribe request for HTTP executor 'default' of framework 8ae838c1-8359-4144-b231-0277c048bb56-0000
I0201 20:32:52.511205 31211 executor.cpp:716] Enqueuing event SUBSCRIBED received from http://172.17.0.3:52781/slave(87)/api/v1/executor
*** Aborted at 1485981172 (unix time) try "date -d @1485981172" if you are using GNU date ***
PC: @ 0x7fb322fdfa17 testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
I0201 20:32:52.528195 31206 slave.cpp:2271] Sending queued task '94110b31-1134-4f11-afab-924548b51fe7' to executor 'default' of framework 8ae838c1-8359-4144-b231-0277c048bb56-0000 (via HTTP)
I0201 20:32:52.532054 31203 executor.cpp:716] Enqueuing event LAUNCH received from http://172.17.0.3:52781/slave(87)/api/v1/executor
*** SIGSEGV (@0x0) received by PID 31177 (TID 0x7fb30a7ab700) from PID 0; stack trace: ***
@ 0x7fb319f68370 (unknown)
@ 0x7fb322fdfa17 testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
@ 0x7fb3220819bb _ZN7testing8internal18FunctionMockerBaseIFvPN5mesos2v18executor5MesosERKNS4_16Event_SubscribedEEE10InvokeWithERKSt5tupleIJS6_S9_EE
@ 0x7fb3220742a7 testing::internal::FunctionMocker<>::Invoke()
@ 0x7fb322069a1b mesos::internal::tests::executor::MockHTTPExecutor<>::subscribed()
@ 0x7fb3220623b5 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0x7fb32205a237 mesos::internal::tests::executor::TestMesos<>::events()
@ 0x7fb322081cef std::_Mem_fn<>::operator()<>()
@ 0x7fb322074dd0 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEE6__callIvIRKSF_EILm0ELm1EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
@ 0x7fb32206a02c _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests8executor9TestMesosINS1_2v18executor5MesosENS7_5EventEEEFvSt5queueIS9_St5dequeIS9_SaIS9_EEEEEPSA_St12_PlaceholderILi1EEEEclIJRKSF_EvEET0_DpOT_
@ 0x7fb3220628fc std::_Function_handler<>::_M_invoke()
@ 0x7fb31e65253d std::function<>::operator()()
@ 0x7fb31e64a013 process::AsyncExecutorProcess::execute<>()
@ 0x7fb31e64a199 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_PvSG_SC_SJ_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_T3_ET4_T5_T6_ENKUlPNS_11ProcessBaseEE_clES11_
@ 0x7fb31e65a0e9 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISC_SaISC_EEEEESG_PvSK_SG_SN_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSS_FSP_T1_T2_T3_ET4_T5_T6_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x7fb31fb8c7ad std::function<>::operator()()
@ 0x7fb31fb708cf process::ProcessBase::visit()
@ 0x7fb31fb7bbd4 process::DispatchEvent::visit()
@ 0x7fb321c90aa6 process::ProcessBase::serve()
@ 0x7fb31fb6c8cb process::ProcessManager::resume()
@ 0x7fb31fb69076 _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
@ 0x7fb31fb7b23c _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x7fb31fb7b180 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
@ 0x7fb31fb7b10a _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x7fb3198f9230 (unknown)
@ 0x7fb319f60dc5 start_thread
@ 0x7fb31906273d __clone
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.0/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1485978961-17861
Untagged: mesos-1485978961-17861:latest
Deleted: sha256:e47ab9f2236b81291c652bed875fe325592b491dce76221ba65151eaf134c742
Deleted: sha256:6602d6b4e0b652e80f876f4e7a10c786109edad67db3546db24d4c89336c0be1
Deleted: sha256:0b878125b1f29a4e57102e4e3f52e0fa22f7a1925769d1993bc615a5782bbfc6
Deleted: sha256:b9ac9a3a1bb0b1d6a269a740ec875afa40739073eab13ed28ff40ddf869060e3
Deleted: sha256:1b0dc00dfa0072b9a58d1f0fcdc8aa097bfb186ca2a26ffceabae03a62e08610
Deleted: sha256:1966aaef968d1e8f6a4a8ede2c46182bf07f36ea74f56db2da247074907f98f4
Deleted: sha256:42f76d215c8ee811924f30b6bf11ca12da8021a5bfa5aab53254d5ef3d64edab
Deleted: sha256:910976c28a7788ca3e9121cb9a06adf5667b76bd8f57b6f9bfcf4d8487af055a
Deleted: sha256:362bf70058a12dbcf9404e1a67962b414500d7a79bb9732164ecd467f6878b0a
Deleted: sha256:3cf698af6052d78b723d4c69e50ca16b1137435207f284ec31ecbe9dc13fc70e
Deleted: sha256:ca6b10dd1e80116f9e0e4fbb8a24d07e5765132ee471482bbd926ae78893547b
Deleted: sha256:c67a37a1eec2978a5914029990ec059833db79686c4ee7b50d9490cbafab735d
Deleted: sha256:8aa865b6c459cc133166ff6049d92e4586bc437f0999a434122fd4a22dbd9d66
Deleted: sha256:fa1a5721e4b588687687029bef55c2ecc3af36a400bc4d094de585acfe01f9f4
Deleted: sha256:7179f73db84d978e539f5a9b0e846ecfe84d54775de4dbe116da7d3e83217367
Deleted: sha256:3dbc1f946792248e141ae4fc4ef32cd00cb2add090611d0e32aa52a84fb2038e
Deleted: sha256:ba04e6772c997497ec474bdedaf6d73589c3bf9674b4485b8c6f85b7dc4761d1
Deleted: sha256:2eec9b1273fb51f0b63412b7eab2c656e629703d8d15554e88a9084901737337
Deleted: sha256:f64f32401b3a2a4db7afa2039485dbbb059357c0ecf6526e90ec069b8ee80bb2
Deleted: sha256:9c58e350d695c4bde509a61083ed494a5e41329953fe8a06f96f27b2f249b346
Deleted: sha256:1f04338f911262adc24ab4c63346d3212f7d37305fe996632d0f7cd0fbca87c8
Deleted: sha256:450b90ad792324aa509cfe5d41e77d5940bd40194910d34c9b561214150d0f83
Deleted: sha256:1cae41700edb44b34c4068322accb97400e5e0fb5be5fc098b6724f3eb6a3530
Deleted: sha256:e4b169267907763de002b3dc904c383a56a415aae84c323343c4f60c31cf791e
Deleted: sha256:0a3551a75a36d2ff81faa4cf0d96b4e49ad3ebf73b742d1e69569d7f214d3e62
Build step 'Execute shell' marked build as failure