You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/05/09 10:25:24 UTC
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3633
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)/3633/display/redirect?page=changes>
Changes:
[yujie.jay] Changed `#elif ...` to `#elif defined(...)` in Mesos.
[yujie.jay] Fixed provisioner recover blockage by non-existing rootfses dir.
[yujie.jay] Added MESOS-7471 to 1.2.1 CHANGELOG.
------------------------------------------
[...truncated 25.33 MB...]
I0509 10:24:24.331549 31504 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.331959 31509 slave.cpp:5550] Finished recovery
I0509 10:24:24.332451 31509 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.332736 31502 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.335336 31500 process.cpp:3704] Handling HTTP event for process 'slave(696)' with path: '/slave(696)/monitor/statistics.json'
I0509 10:24:24.337188 31503 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0509 10:24:24.341181 31499 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (30 ms)
[ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0509 10:24:24.350129 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.350575 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.350683 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.350716 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.353741 31508 slave.cpp:211] Mesos agent started on (697)@172.17.0.2:56369
I0509 10:24:24.353826 31508 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_saVnIZ/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_saVnIZ/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_saVnIZ/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_saVnIZ" --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_X4QwwT"
I0509 10:24:24.354778 31508 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_saVnIZ/credential'
I0509 10:24:24.355123 31508 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.355149 31508 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_saVnIZ/http_credentials'
I0509 10:24:24.355432 31508 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.355636 31508 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.356869 31508 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.356956 31508 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.356969 31508 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.357108 31499 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.358494 31500 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_X4QwwT/meta'
I0509 10:24:24.358806 31505 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.359081 31509 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.360433 31503 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.360869 31507 slave.cpp:5550] Finished recovery
I0509 10:24:24.361549 31507 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.361850 31500 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.364259 31506 process.cpp:3704] Handling HTTP event for process 'slave(697)' with path: '/slave(697)/containers'
I0509 10:24:24.365535 31498 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0509 10:24:24.369318 31479 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (28 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0509 10:24:24.379531 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.380005 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.380101 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.380141 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.383020 31509 slave.cpp:211] Mesos agent started on (698)@172.17.0.2:56369
I0509 10:24:24.383043 31509 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_voOPJo/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_voOPJo/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_voOPJo/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_voOPJo" --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_Gm5eti"
I0509 10:24:24.383524 31509 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_voOPJo/credential'
I0509 10:24:24.383687 31509 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.383713 31509 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_voOPJo/http_credentials'
I0509 10:24:24.383939 31509 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.384099 31509 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.385267 31509 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.385342 31509 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.385359 31509 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.385509 31506 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.386984 31502 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_Gm5eti/meta'
I0509 10:24:24.387331 31506 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.387588 31513 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.389101 31499 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.389525 31510 slave.cpp:5550] Finished recovery
I0509 10:24:24.390085 31510 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.390337 31506 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.393357 31499 process.cpp:3704] Handling HTTP event for process 'slave(698)' with path: '/slave(698)/monitor/statistics'
I0509 10:24:24.394805 31510 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0509 10:24:24.397253 31509 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (28 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0509 10:24:24.411141 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.411909 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.412052 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.412102 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.416990 31513 slave.cpp:211] Mesos agent started on (699)@172.17.0.2:56369
I0509 10:24:24.417033 31513 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_msNo4N/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_msNo4N/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_msNo4N/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_msNo4N" --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_ltfUIH"
I0509 10:24:24.417769 31513 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_msNo4N/credential'
I0509 10:24:24.418009 31513 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.418030 31513 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_msNo4N/http_credentials'
I0509 10:24:24.418257 31513 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.418412 31513 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.419802 31513 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.419883 31513 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.419903 31513 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.420053 31503 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.421967 31503 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_ltfUIH/meta'
I0509 10:24:24.422338 31503 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.422598 31507 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.424134 31499 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.424485 31509 slave.cpp:5550] Finished recovery
I0509 10:24:24.425112 31509 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.425371 31503 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.428724 31505 process.cpp:3704] Handling HTTP event for process 'slave(699)' with path: '/slave(699)/monitor/statistics.json'
I0509 10:24:24.430042 31512 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0509 10:24:24.433123 31479 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (34 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0509 10:24:24.443155 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.443720 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.443874 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.443920 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.447198 31506 slave.cpp:211] Mesos agent started on (700)@172.17.0.2:56369
I0509 10:24:24.447335 31506 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_OdE6Kd/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_OdE6Kd/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_OdE6Kd/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_OdE6Kd" --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_Iy8bk7"
I0509 10:24:24.447870 31506 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_OdE6Kd/credential'
I0509 10:24:24.448110 31506 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.448134 31506 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_OdE6Kd/http_credentials'
I0509 10:24:24.448398 31506 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.448565 31506 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.449851 31506 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.449934 31506 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.449954 31506 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.450110 31500 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.451659 31504 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_Iy8bk7/meta'
I0509 10:24:24.452169 31510 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.452386 31503 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.453902 31503 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.454362 31512 slave.cpp:5550] Finished recovery
I0509 10:24:24.454845 31512 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.455096 31510 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.458230 31513 process.cpp:3704] Handling HTTP event for process 'slave(700)' with path: '/slave(700)/containers'
I0509 10:24:24.459571 31511 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0509 10:24:24.462247 31511 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (29 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0509 10:24:24.471961 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.472452 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.472545 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.472579 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.473980 31479 cluster.cpp:446] Creating default 'local' authorizer
I0509 10:24:24.475471 31501 slave.cpp:211] Mesos agent started on (701)@172.17.0.2:56369
I0509 10:24:24.475498 31501 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_qSTMKD/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_qSTMKD/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_qSTMKD/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_qSTMKD" --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_Qlpbfx"
I0509 10:24:24.476238 31501 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_qSTMKD/credential'
I0509 10:24:24.476444 31501 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.476469 31501 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_qSTMKD/http_credentials'
I0509 10:24:24.476755 31501 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.476907 31501 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.478066 31501 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.478142 31501 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.478157 31501 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.478327 31512 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.479563 31499 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_Qlpbfx/meta'
I0509 10:24:24.479876 31513 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.480065 31507 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.481335 31513 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.481681 31506 slave.cpp:5550] Finished recovery
I0509 10:24:24.482216 31506 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.482484 31505 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.485968 31498 process.cpp:3704] Handling HTTP event for process 'slave(701)' with path: '/slave(701)/monitor/statistics'
I0509 10:24:24.487592 31500 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0509 10:24:24.491405 31505 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (29 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0509 10:24:24.503691 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.504277 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.504421 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.504462 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.506093 31479 cluster.cpp:446] Creating default 'local' authorizer
I0509 10:24:24.507866 31502 slave.cpp:211] Mesos agent started on (702)@172.17.0.2:56369
I0509 10:24:24.507899 31502 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_EmTz33/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_EmTz33/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_EmTz33/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_EmTz33" --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_h3w2sX"
I0509 10:24:24.508486 31502 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_EmTz33/credential'
I0509 10:24:24.508675 31502 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.508698 31502 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_EmTz33/http_credentials'
I0509 10:24:24.508920 31502 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.509063 31502 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.510226 31502 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.510303 31502 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.510315 31502 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.510432 31512 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.511734 31510 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_h3w2sX/meta'
I0509 10:24:24.512037 31502 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.512305 31511 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.513638 31508 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.514011 31509 slave.cpp:5550] Finished recovery
I0509 10:24:24.514519 31509 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.514778 31500 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.517928 31503 process.cpp:3704] Handling HTTP event for process 'slave(702)' with path: '/slave(702)/monitor/statistics.json'
I0509 10:24:24.519454 31505 http.cpp:871] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0509 10:24:24.523401 31498 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (31 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0509 10:24:24.534126 31479 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W0509 10:24:24.534641 31479 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0509 10:24:24.534750 31479 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0509 10:24:24.534785 31479 provisioner.cpp:249] Using default backend 'copy'
I0509 10:24:24.536442 31479 cluster.cpp:446] Creating default 'local' authorizer
I0509 10:24:24.538138 31504 slave.cpp:211] Mesos agent started on (703)@172.17.0.2:56369
I0509 10:24:24.538197 31504 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_87qZGu/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_87qZGu/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_87qZGu/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_87qZGu" --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_2g4l1n"
I0509 10:24:24.539077 31504 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_87qZGu/credential'
I0509 10:24:24.539324 31504 slave.cpp:354] Agent using credential for: test-principal
I0509 10:24:24.539352 31504 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_87qZGu/http_credentials'
I0509 10:24:24.539662 31504 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 10:24:24.539860 31504 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 10:24:24.541802 31504 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 10:24:24.541925 31504 slave.cpp:549] Agent attributes: [ ]
I0509 10:24:24.541947 31504 slave.cpp:554] Agent hostname: 02ccee791194
I0509 10:24:24.542094 31509 status_update_manager.cpp:177] Pausing sending status updates
I0509 10:24:24.543884 31508 state.cpp:62] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_2g4l1n/meta'
I0509 10:24:24.544205 31506 status_update_manager.cpp:203] Recovering status update manager
I0509 10:24:24.544433 31510 containerizer.cpp:600] Recovering containerizer
I0509 10:24:24.545888 31500 provisioner.cpp:410] Provisioner recovery complete
I0509 10:24:24.546281 31508 slave.cpp:5550] Finished recovery
I0509 10:24:24.546950 31508 slave.cpp:5724] Querying resource estimator for oversubscribable resources
I0509 10:24:24.547228 31498 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator
I0509 10:24:24.550282 31511 process.cpp:3704] Handling HTTP event for process 'slave(703)' with path: '/slave(703)/containers'
I0509 10:24:24.551538 31510 http.cpp:871] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0509 10:24:24.555027 31498 slave.cpp:803] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (30 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (274 ms total)
[----------] Global test environment tear-down
[==========] 1491 tests from 167 test cases ran. (437981 ms total)
[ PASSED ] 1490 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] SlaveRecoveryTest/0.RecoverSlaveState, where TypeParam = mesos::internal::slave::MesosContainerizer
1 FAILED TEST
YOU HAVE 11 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.2.1/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.2.1/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.2.1/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.2.1/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1494322958-20659
Untagged: mesos-1494322958-20659:latest
Deleted: sha256:d1b75c7b7f17061b7095570dac9ede0d2dc58d476a2d97f75b5539c1095035d7
Deleted: sha256:4372f030216ffebc344b1eaad5455b55dd739ea7093081af22ec5b10370b45c2
Deleted: sha256:8d4a16e689fc759bac55f8283a571badd20de3f59fa5358a4fc287025ee12071
Deleted: sha256:3267d3856583e8d9f692fb46f583a9a9c1ddb73efe0f4be3fd202134f73e6abb
Deleted: sha256:41d19199e7012f6cfe20619a5dd27bc4b2d59fc86919017b886ccb3749fa158b
Deleted: sha256:0fe25390dabc3751bb2df41c30bf9b34a863dc5406333c3ceb531a8e829ab161
Deleted: sha256:0e597eccc763e960a2db73af6326fe55e623c16d45d9349f1562b181004df5da
Deleted: sha256:ffdf98c46dc163e6f06fe759aa3fd3a9db5473ca9f7242b82955e29d6294b73a
Deleted: sha256:b4eeacde1072af481081148cb50d163c8caa7f78f48d990c9fac7d2ddd692d89
Deleted: sha256:609af054dc1097f3d35a997c05fb2f3774a428a30730eb31e7f8eb5b31da5b58
Deleted: sha256:b25843323f675ca7c4297069c094250edbf71d4a82d8bcc9e3f2b4fdaea6831c
Deleted: sha256:e757653ef5473551c11e8696554e5ab7395c46750b187304d4d0cc252a94c517
Deleted: sha256:569e0fbb66fa4cfb1f6a25154924ea475eeb7637c273340ffd3ffff8059aed3b
Deleted: sha256:916247b15f3845b287a66808e368e01df41b30ac0d2a514259ea20c2c810b8ac
Deleted: sha256:26299857e068b2123d5e5e3abd20036d039b51b849f0901c81c683d392032eee
Deleted: sha256:6f8a8e65237f0f850b221b3cb643d122be04e78b4ae20246d0df50efc2e5e934
Deleted: sha256:ed378a1c488ac36d1bc57ddf550f2f1c4d70cf9410147f8dd7d1b4acb212d105
Deleted: sha256:aed571b15c47f03d36cdb2625a874162a467db33dadb6d528bf11b8eea91bd5b
Deleted: sha256:4a1e60f4ff2a5b0d91db07ceb87d4c87e4ce33be17b1b07afd4fb77775e71991
Deleted: sha256:d8ce2e47d24aa11de80e5dca029de38912ca156658aae908af1c536ccdb06562
Deleted: sha256:3d6d824481b4b601ac3c8f9ba47037f3852d2040e1e248e4b26a6b8531f85952
Deleted: sha256:d5e25ca226774d52352ee7383850d0fdbfa5b39a9ab0c85dd6918f3e3f302690
Deleted: sha256:444822a88db81575817bf234853db08b31035ab3d0e9bc613e09953a12773cc9
Deleted: sha256:8689ffba27675d20946027ca22f6eaf492c8d1d5500f310f64ec0a1e648e86b4
Deleted: sha256:9169b80dfd481cceab2d736b11751791fd7b8051956b84f5d1e1e7ce0855d0e2
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com
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) #3635
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)/3635/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3634
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)/3634/display/redirect?page=changes>
Changes:
[alexr] Removed the "WIP" prefix from 1.1.2 CHANGELOG.
[yujie.jay] Changed `#elif ...` to `#elif defined(...)` in Mesos.
[yujie.jay] Fixed provisioner recover blockage by non-existing rootfses dir.
[yujie.jay] Added MESOS-7471 to 1.1.2 CHANGELOG.
------------------------------------------
[...truncated 21.80 MB...]
I0509 11:34:37.125139 30425 recover.cpp:477] Replica is in STARTING status
I0509 11:34:37.126909 30436 replica.cpp:673] Replica in STARTING status received a broadcasted recover request from __req_res__(6217)@172.17.0.2:50891
I0509 11:34:37.127277 30430 recover.cpp:197] Received a recover response from a replica in STARTING status
I0509 11:34:37.127893 30426 recover.cpp:568] Updating replica status to VOTING
I0509 11:34:37.162312 30429 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 34.200704ms
I0509 11:34:37.162395 30429 replica.cpp:320] Persisted replica status to VOTING
I0509 11:34:37.162617 30429 recover.cpp:582] Successfully joined the Paxos group
I0509 11:34:37.162930 30429 recover.cpp:466] Recover process terminated
I0509 11:34:37.163332 30435 log.cpp:553] Attempting to start the writer
I0509 11:34:37.164726 30425 replica.cpp:493] Replica received implicit promise request from __req_res__(6218)@172.17.0.2:50891 with proposal 1
I0509 11:34:37.191834 30425 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 27.068706ms
I0509 11:34:37.191880 30425 replica.cpp:342] Persisted promised to 1
I0509 11:34:37.192458 30431 coordinator.cpp:238] Coordinator attempting to fill missing positions
I0509 11:34:37.193758 30429 replica.cpp:388] Replica received explicit promise request from __req_res__(6219)@172.17.0.2:50891 for position 0 with proposal 2
I0509 11:34:37.222725 30429 leveldb.cpp:341] Persisting action (8 bytes) to leveldb took 28.917584ms
I0509 11:34:37.222777 30429 replica.cpp:708] Persisted action NOP at position 0
I0509 11:34:37.223834 30429 replica.cpp:537] Replica received write request for position 0 from __req_res__(6220)@172.17.0.2:50891
I0509 11:34:37.223902 30429 leveldb.cpp:436] Reading position from leveldb took 34814ns
I0509 11:34:37.272874 30429 leveldb.cpp:341] Persisting action (14 bytes) to leveldb took 48.917416ms
I0509 11:34:37.272925 30429 replica.cpp:708] Persisted action NOP at position 0
I0509 11:34:37.273525 30435 replica.cpp:691] Replica received learned notice for position 0 from @0.0.0.0:0
I0509 11:34:37.297945 30435 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 24.375493ms
I0509 11:34:37.298004 30435 replica.cpp:708] Persisted action NOP at position 0
I0509 11:34:37.298620 30438 log.cpp:569] Writer started with ending position 0
I0509 11:34:37.299782 30439 leveldb.cpp:436] Reading position from leveldb took 47390ns
I0509 11:34:37.300786 30430 registrar.cpp:362] Successfully fetched the registry (0B) in 204.614656ms
I0509 11:34:37.300907 30430 registrar.cpp:461] Applied 1 operations in 22859ns; attempting to update the registry
I0509 11:34:37.301650 30428 log.cpp:577] Attempting to append 168 bytes to the log
I0509 11:34:37.301780 30433 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 1
I0509 11:34:37.302498 30431 replica.cpp:537] Replica received write request for position 1 from __req_res__(6221)@172.17.0.2:50891
I0509 11:34:37.323148 30431 leveldb.cpp:341] Persisting action (187 bytes) to leveldb took 20.597373ms
I0509 11:34:37.323231 30431 replica.cpp:708] Persisted action APPEND at position 1
I0509 11:34:37.324251 30438 replica.cpp:691] Replica received learned notice for position 1 from @0.0.0.0:0
I0509 11:34:37.348294 30438 leveldb.cpp:341] Persisting action (189 bytes) to leveldb took 23.99431ms
I0509 11:34:37.348382 30438 replica.cpp:708] Persisted action APPEND at position 1
I0509 11:34:37.349737 30436 registrar.cpp:506] Successfully updated the registry in 48.751104ms
I0509 11:34:37.349905 30436 registrar.cpp:392] Successfully recovered registrar
I0509 11:34:37.350006 30438 log.cpp:596] Attempting to truncate the log to 1
I0509 11:34:37.350201 30438 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 2
I0509 11:34:37.350445 30436 master.cpp:1676] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0509 11:34:37.350587 30433 hierarchical.cpp:176] Skipping recovery of hierarchical allocator: nothing to recover
I0509 11:34:37.354022 30424 replica.cpp:537] Replica received write request for position 2 from __req_res__(6222)@172.17.0.2:50891
I0509 11:34:37.375998 30424 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 21.885415ms
I0509 11:34:37.376098 30424 replica.cpp:708] Persisted action TRUNCATE at position 2
I0509 11:34:37.377311 30434 replica.cpp:691] Replica received learned notice for position 2 from @0.0.0.0:0
I0509 11:34:37.398581 30434 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 21.063749ms
I0509 11:34:37.398835 30434 leveldb.cpp:399] Deleting ~1 keys from leveldb took 93239ns
I0509 11:34:37.398895 30434 replica.cpp:708] Persisted action TRUNCATE at position 2
I0509 11:34:37.407181 30432 slave.cpp:208] Mesos agent started on 172.17.0.2:50891
I0509 11:34:37.407778 30405 scheduler.cpp:176] Version: 1.1.2
I0509 11:34:37.407224 30432 slave.cpp:209] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_xWwZhS/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/SlaveTest_KillTaskGroupBetweenRunTaskParts_xWwZhS/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/SlaveTest_KillTaskGroupBetweenRunTaskParts_xWwZhS/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.1.2/_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/SlaveTest_KillTaskGroupBetweenRunTaskParts_xWwZhS" --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/SlaveTest_KillTaskGroupBetweenRunTaskParts_aUfNap"
I0509 11:34:37.407897 30432 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_xWwZhS/credential'
I0509 11:34:37.408109 30432 slave.cpp:346] Agent using credential for: test-principal
I0509 11:34:37.408131 30432 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_xWwZhS/http_credentials'
I0509 11:34:37.408432 30432 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0509 11:34:37.408574 30432 http.cpp:887] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0509 11:34:37.410213 30430 scheduler.cpp:465] New master detected at master@172.17.0.2:50891
I0509 11:34:37.410271 30430 scheduler.cpp:474] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0509 11:34:37.410365 30432 slave.cpp:533] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 11:34:37.410480 30432 slave.cpp:541] Agent attributes: [ ]
I0509 11:34:37.410504 30432 slave.cpp:546] Agent hostname: c8d7080919cd
I0509 11:34:37.412778 30436 state.cpp:57] Recovering state from '/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_aUfNap/meta'
I0509 11:34:37.413163 30426 status_update_manager.cpp:203] Recovering status update manager
I0509 11:34:37.413537 30434 slave.cpp:5281] Finished recovery
I0509 11:34:37.414108 30434 slave.cpp:5455] Querying resource estimator for oversubscribable resources
I0509 11:34:37.414429 30430 status_update_manager.cpp:177] Pausing sending status updates
I0509 11:34:37.414453 30439 slave.cpp:915] New master detected at master@172.17.0.2:50891
I0509 11:34:37.414489 30439 slave.cpp:974] Authenticating with master master@172.17.0.2:50891
I0509 11:34:37.414566 30439 slave.cpp:985] Using default CRAM-MD5 authenticatee
I0509 11:34:37.414731 30439 slave.cpp:947] Detecting new master
I0509 11:34:37.414835 30431 authenticatee.cpp:121] Creating new client SASL connection
I0509 11:34:37.415172 30429 master.cpp:6680] Authenticating (83)@172.17.0.2:50891
I0509 11:34:37.415356 30429 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(968)@172.17.0.2:50891
I0509 11:34:37.415691 30429 authenticator.cpp:98] Creating new server SASL connection
I0509 11:34:37.415843 30438 scheduler.cpp:353] Connected with the master at http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.416039 30429 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0509 11:34:37.416069 30429 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0509 11:34:37.416225 30438 authenticator.cpp:204] Received SASL authentication start
I0509 11:34:37.416301 30438 authenticator.cpp:326] Authentication requires more steps
I0509 11:34:37.416498 30438 authenticatee.cpp:259] Received SASL authentication step
I0509 11:34:37.416743 30438 authenticator.cpp:232] Received SASL authentication step
I0509 11:34:37.416851 30438 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'c8d7080919cd' server FQDN: 'c8d7080919cd' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0509 11:34:37.416879 30438 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0509 11:34:37.416932 30438 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0509 11:34:37.416975 30438 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'c8d7080919cd' server FQDN: 'c8d7080919cd' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0509 11:34:37.416998 30438 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0509 11:34:37.417016 30438 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0509 11:34:37.417063 30438 authenticator.cpp:318] Authentication success
I0509 11:34:37.417243 30433 authenticatee.cpp:299] Authentication success
I0509 11:34:37.417284 30427 master.cpp:6710] Successfully authenticated principal 'test-principal' at (83)@172.17.0.2:50891
I0509 11:34:37.417290 30436 scheduler.cpp:235] Sending SUBSCRIBE call to http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.417286 30438 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(968)@172.17.0.2:50891
I0509 11:34:37.418334 30435 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0509 11:34:37.418473 30439 slave.cpp:1069] Successfully authenticated with master master@172.17.0.2:50891
I0509 11:34:37.418643 30439 slave.cpp:1475] Will retry registration in 13.967579ms if necessary
I0509 11:34:37.419026 30435 master.cpp:5103] Registering agent at (83)@172.17.0.2:50891 (c8d7080919cd) with id c71237fd-ebe4-440f-a93e-5475eded5529-S0
I0509 11:34:37.419472 30425 registrar.cpp:461] Applied 1 operations in 58911ns; attempting to update the registry
I0509 11:34:37.419587 30426 http.cpp:391] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40388
I0509 11:34:37.419880 30426 master.cpp:2313] Received subscription request for HTTP framework 'default'
I0509 11:34:37.419997 30426 master.cpp:2053] Authorizing framework principal 'test-principal' to receive offers for role '*'
I0509 11:34:37.420176 30430 log.cpp:577] Attempting to append 337 bytes to the log
I0509 11:34:37.420455 30430 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 3
I0509 11:34:37.420943 30425 master.cpp:2411] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0509 11:34:37.421674 30430 hierarchical.cpp:275] Added framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.421752 30430 hierarchical.cpp:1694] No allocations performed
I0509 11:34:37.421787 30430 hierarchical.cpp:1789] No inverse offers to send out!
I0509 11:34:37.421855 30430 hierarchical.cpp:1286] Performed allocation for 0 agents in 157101ns
I0509 11:34:37.421967 30430 master.hpp:2163] Sending heartbeat to c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.422181 30430 replica.cpp:537] Replica received write request for position 3 from __req_res__(6223)@172.17.0.2:50891
I0509 11:34:37.423655 30427 scheduler.cpp:671] Enqueuing event SUBSCRIBED received from http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.424216 30427 scheduler.cpp:671] Enqueuing event HEARTBEAT received from http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.433912 30435 slave.cpp:1475] Will retry registration in 36.893601ms if necessary
I0509 11:34:37.434059 30432 master.cpp:5091] Ignoring register agent message from (83)@172.17.0.2:50891 (c8d7080919cd) as admission is already in progress
I0509 11:34:37.457453 30430 leveldb.cpp:341] Persisting action (356 bytes) to leveldb took 35.200376ms
I0509 11:34:37.457546 30430 replica.cpp:708] Persisted action APPEND at position 3
I0509 11:34:37.458478 30438 replica.cpp:691] Replica received learned notice for position 3 from @0.0.0.0:0
I0509 11:34:37.471690 30430 slave.cpp:1475] Will retry registration in 38.755116ms if necessary
I0509 11:34:37.471881 30427 master.cpp:5091] Ignoring register agent message from (83)@172.17.0.2:50891 (c8d7080919cd) as admission is already in progress
I0509 11:34:37.482503 30438 leveldb.cpp:341] Persisting action (358 bytes) to leveldb took 23.8981ms
I0509 11:34:37.482578 30438 replica.cpp:708] Persisted action APPEND at position 3
I0509 11:34:37.484477 30429 registrar.cpp:506] Successfully updated the registry in 64.900096ms
I0509 11:34:37.484715 30427 log.cpp:596] Attempting to truncate the log to 3
I0509 11:34:37.484848 30425 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 4
I0509 11:34:37.485659 30435 master.cpp:5174] Registered agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 at (83)@172.17.0.2:50891 (c8d7080919cd) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0509 11:34:37.486027 30434 hierarchical.cpp:485] Added agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 (c8d7080919cd) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0509 11:34:37.486593 30428 replica.cpp:537] Replica received write request for position 4 from __req_res__(6224)@172.17.0.2:50891
I0509 11:34:37.487938 30434 hierarchical.cpp:1789] No inverse offers to send out!
I0509 11:34:37.488072 30434 hierarchical.cpp:1309] Performed allocation for agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 in 2.003269ms
I0509 11:34:37.488173 30425 slave.cpp:4133] Received ping from slave-observer(434)@172.17.0.2:50891
I0509 11:34:37.488353 30433 master.cpp:6509] Sending 1 offers to framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 (default)
I0509 11:34:37.488378 30425 slave.cpp:1115] Registered with master master@172.17.0.2:50891; given agent ID c71237fd-ebe4-440f-a93e-5475eded5529-S0
I0509 11:34:37.488404 30425 fetcher.cpp:90] Clearing fetcher cache
I0509 11:34:37.488637 30437 status_update_manager.cpp:184] Resuming sending status updates
I0509 11:34:37.488857 30425 slave.cpp:1138] Checkpointing SlaveInfo to '/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_aUfNap/meta/slaves/c71237fd-ebe4-440f-a93e-5475eded5529-S0/slave.info'
I0509 11:34:37.490201 30430 scheduler.cpp:671] Enqueuing event OFFERS received from http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.492532 30425 scheduler.cpp:235] Sending ACCEPT call to http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.493407 30435 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0509 11:34:37.494307 30431 http.cpp:391] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40387
I0509 11:34:37.495142 30431 master.cpp:3554] Processing ACCEPT call for offers: [ c71237fd-ebe4-440f-a93e-5475eded5529-O0 ] on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 at (83)@172.17.0.2:50891 (c8d7080919cd) for framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 (default)
I0509 11:34:37.495246 30431 master.cpp:3159] Authorizing framework principal 'test-principal' to launch task ebf3ec17-2aac-4255-912b-d698edf3497c
I0509 11:34:37.495543 30431 master.cpp:3159] Authorizing framework principal 'test-principal' to launch task 3a046b3e-771d-4d12-a3de-65ec857f6a51
I0509 11:34:37.498735 30431 master.cpp:8262] Adding task ebf3ec17-2aac-4255-912b-d698edf3497c with resources cpus(*):0.1; mem(*):32; disk(*):32 on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 (c8d7080919cd)
I0509 11:34:37.499084 30431 master.cpp:8262] Adding task 3a046b3e-771d-4d12-a3de-65ec857f6a51 with resources cpus(*):0.1; mem(*):32; disk(*):32 on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 (c8d7080919cd)
I0509 11:34:37.499281 30431 master.cpp:4397] Launching task group { 3a046b3e-771d-4d12-a3de-65ec857f6a51, ebf3ec17-2aac-4255-912b-d698edf3497c } of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 (default) with resources cpus(*):0.2; mem(*):64; disk(*):64 on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 at (83)@172.17.0.2:50891 (c8d7080919cd)
I0509 11:34:37.499797 30438 slave.cpp:1539] Got assigned task group containing tasks [ ebf3ec17-2aac-4255-912b-d698edf3497c, 3a046b3e-771d-4d12-a3de-65ec857f6a51 ] for framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.500180 30424 hierarchical.cpp:1018] Recovered cpus(*):1.7; mem(*):928; disk(*):928; ports(*):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):0.3; mem(*):96; disk(*):96) on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 from framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.500241 30424 hierarchical.cpp:1055] Framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 filtered agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 for 5secs
I0509 11:34:37.501157 30433 scheduler.cpp:235] Sending KILL call to http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.501938 30429 process.cpp:3377] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0509 11:34:37.502636 30433 http.cpp:391] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40387
I0509 11:34:37.502780 30433 master.cpp:4711] Telling agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 at (83)@172.17.0.2:50891 (c8d7080919cd) to kill task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 (default)
I0509 11:34:37.502939 30438 slave.cpp:2288] Asked to kill task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
W0509 11:34:37.502985 30438 slave.cpp:2329] Killing task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 before it was launched
I0509 11:34:37.503576 30405 slave.cpp:1701] Launching task group containing tasks [ ebf3ec17-2aac-4255-912b-d698edf3497c, 3a046b3e-771d-4d12-a3de-65ec857f6a51 ] for framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
W0509 11:34:37.503720 30405 slave.cpp:1741] Ignoring running task group containing tasks [ ebf3ec17-2aac-4255-912b-d698edf3497c, 3a046b3e-771d-4d12-a3de-65ec857f6a51 ] of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 because it has been killed in the meantime
I0509 11:34:37.503906 30405 slave.cpp:3634] Handling status update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 from @0.0.0.0:0
W0509 11:34:37.503978 30405 slave.cpp:3730] Could not find the executor for status update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.504264 30436 status_update_manager.cpp:323] Received status update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.504349 30436 status_update_manager.cpp:500] Creating StatusUpdate stream for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.504300 30405 slave.cpp:3634] Handling status update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 from @0.0.0.0:0
W0509 11:34:37.504431 30405 slave.cpp:3730] Could not find the executor for status update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.504688 30405 slave.cpp:4734] Cleaning up framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.504755 30436 status_update_manager.cpp:377] Forwarding update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 to the agent
E0509 11:34:37.504827 30405 slave.cpp:5435] Failed to find the mtime of '/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_aUfNap/slaves/c71237fd-ebe4-440f-a93e-5475eded5529-S0/frameworks/c71237fd-ebe4-440f-a93e-5475eded5529-0000': Error invoking stat for '/tmp/SlaveTest_KillTaskGroupBetweenRunTaskParts_aUfNap/slaves/c71237fd-ebe4-440f-a93e-5475eded5529-S0/frameworks/c71237fd-ebe4-440f-a93e-5475eded5529-0000': No such file or directory
I0509 11:34:37.504978 30430 slave.cpp:4051] Forwarding the update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 to master@172.17.0.2:50891
I0509 11:34:37.505023 30436 status_update_manager.cpp:323] Received status update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505067 30436 status_update_manager.cpp:500] Creating StatusUpdate stream for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505131 30430 slave.cpp:3945] Status update manager successfully handled status update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505304 30431 master.cpp:5707] Status update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 from agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 at (83)@172.17.0.2:50891 (c8d7080919cd)
I0509 11:34:37.505360 30431 master.cpp:5769] Forwarding status update TASK_KILLED (UUID: fb77f9e1-c49c-4acb-a72e-e7df74ef8836) for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505383 30436 status_update_manager.cpp:377] Forwarding update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 to the agent
I0509 11:34:37.505602 30437 slave.cpp:4051] Forwarding the update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 to master@172.17.0.2:50891
I0509 11:34:37.505659 30431 master.cpp:7640] Updating the state of task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0509 11:34:37.505667 30436 status_update_manager.cpp:285] Closing status update streams for framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505792 30436 status_update_manager.cpp:531] Cleaning up status update stream for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505844 30437 slave.cpp:3945] Status update manager successfully handled status update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.505970 30436 status_update_manager.cpp:531] Cleaning up status update stream for task ebf3ec17-2aac-4255-912b-d698edf3497c of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.506196 30431 master.cpp:5707] Status update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 from agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 at (83)@172.17.0.2:50891 (c8d7080919cd)
I0509 11:34:37.506243 30431 master.cpp:5769] Forwarding status update TASK_KILLED (UUID: 7975a98d-1451-446e-9882-65c92413f61e) for task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.506273 30430 hierarchical.cpp:1018] Recovered cpus(*):0.1; mem(*):32; disk(*):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):0.2; mem(*):64; disk(*):64) on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 from framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.506443 30431 master.cpp:7640] Updating the state of task 3a046b3e-771d-4d12-a3de-65ec857f6a51 of framework c71237fd-ebe4-440f-a93e-5475eded5529-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0509 11:34:37.506877 30427 hierarchical.cpp:1018] Recovered cpus(*):0.1; mem(*):32; disk(*):32 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*):0.1; mem(*):32; disk(*):32) on agent c71237fd-ebe4-440f-a93e-5475eded5529-S0 from framework c71237fd-ebe4-440f-a93e-5475eded5529-0000
I0509 11:34:37.507390 30426 scheduler.cpp:671] Enqueuing event UPDATE received from http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.507928 30426 scheduler.cpp:671] Enqueuing event UPDATE received from http://172.17.0.2:50891/master/api/v1/scheduler
I0509 11:34:37.509778 30437 slave.cpp:787] Agent terminating
*** Aborted at 1494329677 (unix time) try "date -d @1494329677" if you are using GNU date ***
I0509 11:34:37.516649 30428 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 29.976487ms
I0509 11:34:37.516736 30428 replica.cpp:708] Persisted action TRUNCATE at position 4
I0509 11:34:37.517720 30436 replica.cpp:691] Replica received learned notice for position 4 from @0.0.0.0:0
PC: @ 0x7fe365bfa8f6 mesos::FrameworkInfo::checkpoint()
*** SIGSEGV (@0x88) received by PID 30405 (TID 0x7fe3530cc700) from PID 136; stack trace: ***
@ 0x7fe30b767fc5 (unknown)
@ 0x7fe30b76d2c1 (unknown)
@ 0x7fe30b7610a8 (unknown)
@ 0x7fe361877370 (unknown)
@ 0x7fe365bfa8f6 mesos::FrameworkInfo::checkpoint()
@ 0x7fe366079f94 mesos::internal::slave::Slave::finalize()
I0509 11:34:37.550155 30436 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 32.371822ms
I0509 11:34:37.550290 30436 leveldb.cpp:399] Deleting ~2 keys from leveldb took 60459ns
I0509 11:34:37.550317 30436 replica.cpp:708] Persisted action TRUNCATE at position 4
@ 0x7fe366cb31ff process::ProcessBase::visit()
@ 0x7fe366cb8e2c process::TerminateEvent::visit()
@ 0xa1eb94 process::ProcessBase::serve()
@ 0x7fe366cacf3f process::ProcessManager::resume()
@ 0x7fe366ca9c2d _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv
@ 0x7fe366cb84d0 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x7fe366cb8427 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv
@ 0x7fe366cb83c0 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x7fe361208230 (unknown)
@ 0x7fe36186fdc5 start_thread
@ 0x7fe36097173d __clone
make[4]: *** [check-local] Segmentation fault
make[4]: Leaving directory `/mesos/mesos-1.1.2/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.1.2/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.1.2/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.1.2/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1494327123-741
Untagged: mesos-1494327123-741:latest
Deleted: sha256:157ea05b6e984ba8b0a90b17a973f84809b71427110066904a11133dad46ae90
Deleted: sha256:f86f46771ba52dda52f3e2dae2532b0ed6948cc7ac13b091edb1b298dfcb8f07
Deleted: sha256:39f33ef63f353ba35335c30b06a8c61d3046acd6f6c0ca031b2360bdb20da76a
Deleted: sha256:1bce7848035180cd012a5cc094ec6b094b5c9a0d4bf8ebe94e51f60c28bffa5d
Deleted: sha256:87b52d09d81e24009f99bb4bdf627b088792fa8c18c3e180c32bc3c7fc7b7038
Deleted: sha256:dfa0e9b5f941746f9fa66794c556ee1abc878c81516c6e6cf74718b03eb5800b
Deleted: sha256:a577baa5fdcec2f395357cfe8c11059a61575d0a8a6934c498e2c46dcfcff3e4
Deleted: sha256:2105dc8bccb26c479cfda1faf59a701ca00f9c6604b23dd77693b93d29a105ee
Deleted: sha256:31c2e195f591f61ca71bc569b1ac68a594f6fb5a2f285a5841c8c740c653c808
Deleted: sha256:74cd04bf0e08b4f7d6b47ce76fe573a8f156798d7403621cf982e0b55518ec22
Deleted: sha256:1d5a324bdae47468f14222a9e605055fb4b95c23fdc98850959c1cbd1b654370
Deleted: sha256:7d2b5887d50919329d397956665e8eb21a0b559b08b0e4bac0015121731a1631
Deleted: sha256:b4e868f86f7cd94c8dcb12375568927e662d57e9320f1d834bfd2510e868ef76
Deleted: sha256:6041006787fdd69d3452b63ecaa43da8d8ac389de259964d09e2c3cd8671d816
Deleted: sha256:a547b27c977eae82bdaffcb79e215c2b5c54f3175fcc1e1be4d97596ea1d1cfe
Deleted: sha256:8ebc0052907f44593ef2da4eb881d8cd66a52c72903588febea05e3edcfa0c11
Deleted: sha256:2c953e1537ac2e557adef4875576fb72150239860df2e7035ae604db06b63c50
Deleted: sha256:c206058ab30a113da217d623c95b6741dc496bd01bc4bd79e9c48fa2a3430f2d
Deleted: sha256:e6b138a79cbddc751b4c2e5a3299e27f78ab1a3cd7d26f9a6a45f23140f120c8
Deleted: sha256:b2857344716616df77bd71d1955e7a2cde884ac975ee0a16b6fb1cdbbf96094c
Deleted: sha256:892c4182924c6a1065932f031ae0d12f7d377fab8066fb7e370300d7208835d9
Deleted: sha256:9e6ac1ea13fdaf8f0f7b0a20d3c6856544f64ec3711f47c4d47ccd23086ea233
Deleted: sha256:bfa884107f7ceadddd0691150f25003330c6fcc1824404eb72b0de800a59d3f4
Deleted: sha256:c98f49f53658d18653142c32dd20d6842e869fe92b56992939e0c90ff82e6441
Deleted: sha256:5064b49b0f8122638ec63693c3b9f95bec56d95a7d9b40e862de6c9398e13254
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com