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/06/24 00:27:35 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3835
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3835/display/redirect>
------------------------------------------
[...truncated 27.36 MB...]
I0624 00:27:29.685812 30646 http.cpp:1114] HTTP GET for /slave(766)/monitor/statistics.json from 172.17.0.3:42332
I0624 00:27:29.686046 30646 http.cpp:935] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0624 00:27:29.691208 30644 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/1 (48 ms)
[ RUN ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2
I0624 00:27:29.707603 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:29.708441 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:29.708624 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:29.708721 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:29.714097 30651 slave.cpp:249] Mesos agent started on (767)@172.17.0.3:44857
I0624 00:27:29.714169 30651 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_vVQpBj/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_vVQpBj/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/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_vVQpBj/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_vVQpBj/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_vVQpBj/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_vVQpBj" --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_BiwsT8"
I0624 00:27:29.715062 30651 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_vVQpBj/credential'
I0624 00:27:29.715394 30651 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:29.715435 30651 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_vVQpBj/http_credentials'
I0624 00:27:29.715986 30651 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:29.716305 30651 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:29.718495 30651 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:29.718823 30651 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:29.718837 30651 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:29.719131 30648 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:29.721513 30647 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_BiwsT8/meta'
I0624 00:27:29.721941 30646 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:29.722465 30648 containerizer.cpp:582] Recovering containerizer
I0624 00:27:29.724848 30652 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:29.725504 30651 slave.cpp:6162] Finished recovery
I0624 00:27:29.726192 30651 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:29.726706 30645 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:29.730454 30647 process.cpp:3779] Handling HTTP event for process 'slave(767)' with path: '/slave(767)/containers'
I0624 00:27:29.732259 30649 http.cpp:1114] HTTP GET for /slave(767)/containers from 172.17.0.3:42334
I0624 00:27:29.732367 30649 http.cpp:935] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0624 00:27:29.736877 30646 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (46 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I0624 00:27:29.753041 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:29.753937 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:29.754237 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:29.754278 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:29.760980 30652 slave.cpp:249] Mesos agent started on (768)@172.17.0.3:44857
I0624 00:27:29.761032 30652 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rvyXQ0/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_rvyXQ0/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rvyXQ0/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rvyXQ0/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rvyXQ0/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_rvyXQ0" --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_7Irw1P"
I0624 00:27:29.761986 30652 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rvyXQ0/credential'
I0624 00:27:29.762416 30652 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:29.762483 30652 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_rvyXQ0/http_credentials'
I0624 00:27:29.762966 30652 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:29.763317 30652 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:29.765482 30652 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:29.765895 30652 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:29.765914 30652 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:29.766286 30646 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:29.768481 30649 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_7Irw1P/meta'
I0624 00:27:29.769115 30645 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:29.769529 30648 containerizer.cpp:582] Recovering containerizer
I0624 00:27:29.771571 30645 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:29.772279 30647 slave.cpp:6162] Finished recovery
I0624 00:27:29.772956 30647 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:29.773381 30650 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:29.777782 30646 process.cpp:3779] Handling HTTP event for process 'slave(768)' with path: '/slave(768)/monitor/statistics'
I0624 00:27:29.779865 30652 http.cpp:1114] HTTP GET for /slave(768)/monitor/statistics from 172.17.0.3:42336
I0624 00:27:29.780030 30652 http.cpp:935] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0624 00:27:29.784049 30644 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (46 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I0624 00:27:29.800689 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:29.801533 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:29.801853 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:29.801934 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:29.808182 30646 slave.cpp:249] Mesos agent started on (769)@172.17.0.3:44857
I0624 00:27:29.808470 30646 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_51yVAI/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_51yVAI/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_51yVAI/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_51yVAI/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_51yVAI/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_51yVAI" --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_DhrSDx"
I0624 00:27:29.809706 30646 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_51yVAI/credential'
I0624 00:27:29.810061 30646 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:29.810114 30646 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_51yVAI/http_credentials'
I0624 00:27:29.810657 30646 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:29.810981 30646 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:29.813052 30646 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:29.813443 30646 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:29.813486 30646 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:29.813959 30652 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:29.816009 30646 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_DhrSDx/meta'
I0624 00:27:29.816756 30647 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:29.817071 30648 containerizer.cpp:582] Recovering containerizer
I0624 00:27:29.819166 30649 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:29.819952 30648 slave.cpp:6162] Finished recovery
I0624 00:27:29.820662 30648 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:29.821059 30649 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:29.824693 30651 process.cpp:3779] Handling HTTP event for process 'slave(769)' with path: '/slave(769)/monitor/statistics.json'
I0624 00:27:29.826577 30650 http.cpp:1114] HTTP GET for /slave(769)/monitor/statistics.json from 172.17.0.3:42338
I0624 00:27:29.826745 30650 http.cpp:935] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0624 00:27:29.830612 30646 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (66 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I0624 00:27:29.866855 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:29.867580 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:29.867739 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:29.867779 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:29.872886 30648 slave.cpp:249] Mesos agent started on (770)@172.17.0.3:44857
I0624 00:27:29.872957 30648 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_hkR0Yq/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_hkR0Yq/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/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_hkR0Yq/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_hkR0Yq/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_hkR0Yq/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_hkR0Yq" --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_d0KaRf"
I0624 00:27:29.873659 30648 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_hkR0Yq/credential'
I0624 00:27:29.873903 30648 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:29.873924 30648 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_hkR0Yq/http_credentials'
I0624 00:27:29.874207 30648 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:29.874460 30648 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:29.876482 30648 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:29.876812 30648 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:29.876829 30648 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:29.877112 30645 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:29.879516 30645 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_d0KaRf/meta'
I0624 00:27:29.880137 30645 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:29.880661 30646 containerizer.cpp:582] Recovering containerizer
I0624 00:27:29.882647 30647 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:29.883332 30646 slave.cpp:6162] Finished recovery
I0624 00:27:29.884265 30646 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:29.886454 30652 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:29.890411 30649 process.cpp:3779] Handling HTTP event for process 'slave(770)' with path: '/slave(770)/containers'
I0624 00:27:29.892349 30650 http.cpp:1114] HTTP GET for /slave(770)/containers from 172.17.0.3:42340
I0624 00:27:29.892460 30650 http.cpp:935] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0624 00:27:29.895764 30645 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (45 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I0624 00:27:29.911453 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:29.912158 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:29.912309 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:29.912346 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:29.915035 30644 cluster.cpp:448] Creating default 'local' authorizer
I0624 00:27:29.917635 30649 slave.cpp:249] Mesos agent started on (771)@172.17.0.3:44857
I0624 00:27:29.917690 30649 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZuJ3S9/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_ZuJ3S9/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/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZuJ3S9/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZuJ3S9/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZuJ3S9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_ZuJ3S9" --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_x8n0DY"
I0624 00:27:29.918623 30649 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZuJ3S9/credential'
I0624 00:27:29.919050 30649 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:29.919081 30649 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_ZuJ3S9/http_credentials'
I0624 00:27:29.919632 30649 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:29.920058 30649 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:29.922250 30649 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:29.922659 30649 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:29.922677 30649 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:29.923238 30646 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:29.925297 30651 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_x8n0DY/meta'
I0624 00:27:29.926245 30646 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:29.926673 30652 containerizer.cpp:582] Recovering containerizer
I0624 00:27:29.929040 30652 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:29.929569 30646 slave.cpp:6162] Finished recovery
I0624 00:27:29.931036 30646 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:29.931547 30646 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:29.935889 30652 process.cpp:3779] Handling HTTP event for process 'slave(771)' with path: '/slave(771)/monitor/statistics'
I0624 00:27:29.938062 30652 http.cpp:1114] HTTP GET for /slave(771)/monitor/statistics from 172.17.0.3:42342
I0624 00:27:29.938171 30652 http.cpp:935] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I0624 00:27:29.943827 30647 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (47 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I0624 00:27:29.959151 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:29.959861 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:29.960019 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:29.960058 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:29.962690 30644 cluster.cpp:448] Creating default 'local' authorizer
I0624 00:27:29.965415 30651 slave.cpp:249] Mesos agent started on (772)@172.17.0.3:44857
I0624 00:27:29.965487 30651 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_70vOhT/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_70vOhT/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/Endpoint_SlaveEndpointTest_NoAuthorizer_1_70vOhT/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_70vOhT/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_70vOhT/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_70vOhT" --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_dI92UH"
I0624 00:27:29.966475 30651 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_70vOhT/credential'
I0624 00:27:29.967020 30651 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:29.967048 30651 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_70vOhT/http_credentials'
I0624 00:27:29.967566 30651 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:29.967995 30651 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:29.970259 30651 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:29.970590 30651 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:29.970607 30651 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:29.971171 30652 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:29.973078 30646 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_dI92UH/meta'
I0624 00:27:29.973697 30648 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:29.974165 30648 containerizer.cpp:582] Recovering containerizer
I0624 00:27:29.976297 30648 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:29.976981 30650 slave.cpp:6162] Finished recovery
I0624 00:27:29.977898 30650 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:29.978896 30650 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:29.983175 30647 process.cpp:3779] Handling HTTP event for process 'slave(772)' with path: '/slave(772)/monitor/statistics.json'
I0624 00:27:29.984936 30646 http.cpp:1114] HTTP GET for /slave(772)/monitor/statistics.json from 172.17.0.3:42344
I0624 00:27:29.985107 30646 http.cpp:935] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I0624 00:27:29.990295 30650 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (48 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I0624 00:27:30.007992 30644 containerizer.cpp:230] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni,environment_secret
W0624 00:27:30.008703 30644 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W0624 00:27:30.008858 30644 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0624 00:27:30.008896 30644 provisioner.cpp:255] Using default backend 'copy'
I0624 00:27:30.011432 30644 cluster.cpp:448] Creating default 'local' authorizer
I0624 00:27:30.014010 30650 slave.cpp:249] Mesos agent started on (773)@172.17.0.3:44857
I0624 00:27:30.014067 30650 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jtdUbD/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_jtdUbD/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/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jtdUbD/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jtdUbD/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jtdUbD/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_jtdUbD" --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_BMheHr"
I0624 00:27:30.014835 30650 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jtdUbD/credential'
I0624 00:27:30.015064 30650 slave.cpp:282] Agent using credential for: test-principal
I0624 00:27:30.015218 30650 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_jtdUbD/http_credentials'
I0624 00:27:30.015692 30650 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0624 00:27:30.015911 30650 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0624 00:27:30.018072 30650 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0624 00:27:30.018398 30650 slave.cpp:561] Agent attributes: [ ]
I0624 00:27:30.018412 30650 slave.cpp:566] Agent hostname: bc94ee919a6f
I0624 00:27:30.018772 30651 status_update_manager.cpp:177] Pausing sending status updates
I0624 00:27:30.021515 30650 state.cpp:64] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_BMheHr/meta'
I0624 00:27:30.022122 30648 status_update_manager.cpp:203] Recovering status update manager
I0624 00:27:30.022495 30650 containerizer.cpp:582] Recovering containerizer
I0624 00:27:30.024909 30649 provisioner.cpp:416] Provisioner recovery complete
I0624 00:27:30.025718 30647 slave.cpp:6162] Finished recovery
I0624 00:27:30.026291 30647 slave.cpp:6344] Querying resource estimator for oversubscribable resources
I0624 00:27:30.026803 30646 slave.cpp:6358] Received oversubscribable resources {} from the resource estimator
I0624 00:27:30.030391 30647 process.cpp:3779] Handling HTTP event for process 'slave(773)' with path: '/slave(773)/containers'
I0624 00:27:30.031929 30648 http.cpp:1114] HTTP GET for /slave(773)/containers from 172.17.0.3:42346
I0624 00:27:30.032044 30648 http.cpp:935] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I0624 00:27:30.044260 30646 slave.cpp:818] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (51 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (453 ms total)
[----------] Global test environment tear-down
[==========] 1571 tests from 171 test cases ran. (378679 ms total)
[ PASSED ] 1570 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] ContentType/AgentAPIStreamingTest.AttachInputToNestedContainerSession/1, where GetParam() = application/json
1 FAILED TEST
YOU HAVE 20 DISABLED TESTS
I0624 00:27:30.184974 30653 process.cpp:968] Failed to accept socket: future discarded
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Error 1
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make[1]: Leaving directory `/mesos/build'
make: *** [check] Error 2
+ docker rmi mesos-1498260020-27227
Untagged: mesos-1498260020-27227:latest
Deleted: sha256:457877ebc295e0a503c6c213b2963eef38d3284456fef116a2fa8968658b36bb
Deleted: sha256:eb274798f4381f5cd574d85091c48a4d3b592453aca15237f844ac6cc6703fa6
Deleted: sha256:67fb51a0770ef1efd982e686d2dcdeab14e1a1a53d323cb15424b8879ed900e2
Deleted: sha256:fadf750f8e873275b1d198aaad2e9c2fc2a9805c1b095d453bebc069320e68b4
Deleted: sha256:72399fa2999a8982097ea5377081e5a11a6e00306cf6f752f88e6fb903acd67d
Deleted: sha256:121af4ca9df985df20dad9935c87fb52712575c7d39a5de08d188cfc6b55ceb8
Deleted: sha256:93f6c4899bf478f70271f32deafdc309e77c995ffb6d18794e0041cc13635a83
Deleted: sha256:cc0deb5da00cb73474dd41b4bdb0e87dfe6a820d4f59bb864f84e1781ab99c6f
Deleted: sha256:1e13ad24b766b701e9e6426b37d9665def3546588f5dd694d93cc8246403499e
Deleted: sha256:3b5f297b81d7bbcfdd6a6db03a8b4246497c66d25d92c1ddc48ca805f597471a
Deleted: sha256:666263121b242030b129448ccfe4695c79ca840b994161dfd89a4dfad7b47409
Deleted: sha256:bbc24a766898b3b6f61bb2c429f9e1ef4a4fcb50062a86e91ef1ac48871c7f41
Deleted: sha256:360c94ef03d208ffad5bb7f022ccf653baedd7f446bface89236b15110bc6b35
Deleted: sha256:91df287102816af68e9cc866a805f79852576b497f229425e1b5875d4b6be7b9
Deleted: sha256:7f0d8df217680e28bbb91fea1de7f8cd6791183b6f58aea373574d6df870cce9
Deleted: sha256:1778c0e8c34d202a99a3804d259eea096dcf404ae63b93c8291f68222f97092c
Deleted: sha256:09783cba7e01ecc9d9a6f072d933e267c0b2dc09d3e26235422cea10ea08c820
Deleted: sha256:54ca973cca423dabf20e3ca61516a846a67116fb5c2f61b44021784df7514d8a
Deleted: sha256:40fc2e953416e3e8da8821d4216a6f28370830cf0e4f0b62b446bd82d5ee8b6f
Deleted: sha256:6ba305ce954b705bf6afc26836c0242cb4a50175ddd4501028ebe560e5756ee0
Deleted: sha256:06edf5bead030db5341ea4962b971a8548bbd35a8acebc0a544f40a93156e98f
Deleted: sha256:6deba3482427698f1520ec4dc534d6c0beca60207bf948b1f04261c6822c11cd
Deleted: sha256:0e9563d50368bf2e684ac5797505e5e01e0b791018134b497e713053fb07a7cd
Deleted: sha256:c8f473838165db1cc988b99ced4efc09dc5134eae9e645bc9ae762568d4789f8
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3837
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3837/display/redirect?page=changes>
Re: Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3836
Posted by Vinod Kone <vi...@apache.org>.
oops: https://issues.apache.org/jira/browse/MESOS-7724
On Tue, Jun 27, 2017 at 10:35 AM, Vinod Kone <vi...@apache.org> wrote:
> filed https://issues.apache.org/jira/browse/MESOS-5812
>
> On Sat, Jun 24, 2017 at 10:38 PM, Apache Jenkins Server <
> jenkins@builds.apache.org> wrote:
>
>> See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmak
>> e,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=
>> 1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!
>> ubuntu-us1)&&(!ubuntu-eu2)/3836/display/redirect?page=changes>
>>
>> Changes:
>>
>> [neil.conway] Documented the content of the `SlaveInfo.resources` field.
>>
>> [neil.conway] Documented resource format in agent <-> master protocol.
>>
>> [neil.conway] Added comment to master logic for downgrading checkpointed
>> resources.
>>
>> [neil.conway] Added sanity check to resource downgrade on agent
>> registration.
>>
>> [neil.conway] Avoided master crash on agent re-registration.
>>
>> [neil.conway] Avoided master crash on re-registration of old agents.
>>
>> [neil.conway] Updated comments and help text in mesos-execute.
>>
>> ------------------------------------------
>> [...truncated 22.40 MB...]
>> I0625 05:38:36.607939 30654 slave.cpp:249] Mesos agent started on (602)@
>> 172.17.0.2:41689
>> I0625 05:38:36.608008 30654 slave.cpp:250] Flags at startup: --acls=""
>> --appc_simple_discovery_uri_prefix="http://"
>> --appc_store_dir="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/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/ContentType_MasterAPITest_Subscribe_0_7l7vGt/credential"
>> --default_role="*" --disk_watch_interval="1mins" --docker="docker"
>> --docker_kill_orphans="true" --docker_registry="https://reg
>> istry-1.docker.io" --docker_remove_delay="6hrs"
>> --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns"
>> --docker_store_dir="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/store/docker"
>> --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume"
>> --enforce_container_disk_quota="false" --executor_registration_timeout="1mins"
>> --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs"
>> --fetcher_cache_dir="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/fetch"
>> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
>> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
>> --hostname_lookup="true" --http_command_executor="false"
>> --http_credentials="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/http_credentials"
>> --http_heartbeat_interval="30secs" --initialize_driver_logging="true"
>> --isolation="posix/cpu,posix/mem" --launcher="posix"
>> --launcher_dir="/mesos/build/src" --logbufsecs="0"
>> --logging_level="INFO" --max_completed_executors_per_framework="150"
>> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
>> --perf_interval="1mins" --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/ContentType_MasterAPITest_Subscribe_0_7l7vGt"
>> --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/ContentType_MasterAPITest_Subscribe_0_XhgpN3"
>> I0625 05:38:36.609035 30654 credentials.hpp:86] Loading credential for
>> authentication from '/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/
>> credential'
>> I0625 05:38:36.609429 30654 slave.cpp:282] Agent using credential for:
>> test-principal
>> I0625 05:38:36.609463 30654 credentials.hpp:37] Loading credentials for
>> authentication from '/tmp/ContentType_MasterAPITes
>> t_Subscribe_0_7l7vGt/http_credentials'
>> I0625 05:38:36.609714 30646 scheduler.cpp:184] Version: 1.4.0
>> I0625 05:38:36.610194 30654 http.cpp:974] Creating default 'basic' HTTP
>> authenticator for realm 'mesos-agent-readonly'
>> I0625 05:38:36.610607 30654 http.cpp:974] Creating default 'basic' HTTP
>> authenticator for realm 'mesos-agent-readwrite'
>> I0625 05:38:36.611371 30651 scheduler.cpp:470] New master detected at
>> master@172.17.0.2:41689
>> I0625 05:38:36.611460 30651 scheduler.cpp:479] Waiting for 0ns before
>> initiating a re-(connection) attempt with the master
>> I0625 05:38:36.613392 30654 slave.cpp:553] Agent resources:
>> [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"
>> name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"nam
>> e":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"nam
>> e":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},
>> "type":"RANGES"}]
>> I0625 05:38:36.613749 30654 slave.cpp:561] Agent attributes: [ ]
>> I0625 05:38:36.613900 30654 slave.cpp:566] Agent hostname: 7bd48084f726
>> I0625 05:38:36.614372 30651 status_update_manager.cpp:177] Pausing
>> sending status updates
>> I0625 05:38:36.617635 30654 state.cpp:64] Recovering state from
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/meta'
>> I0625 05:38:36.624533 30654 status_update_manager.cpp:203] Recovering
>> status update manager
>> I0625 05:38:36.625260 30652 slave.cpp:6168] Finished recovery
>> I0625 05:38:36.626006 30652 slave.cpp:6350] Querying resource estimator
>> for oversubscribable resources
>> I0625 05:38:36.626371 30650 slave.cpp:6364] Received oversubscribable
>> resources {} from the resource estimator
>> I0625 05:38:36.626725 30650 slave.cpp:946] New master detected at
>> master@172.17.0.2:41689
>> I0625 05:38:36.626927 30650 slave.cpp:981] Detecting new master
>> I0625 05:38:36.627110 30648 status_update_manager.cpp:177] Pausing
>> sending status updates
>> I0625 05:38:36.628080 30648 scheduler.cpp:361] Connected with the master
>> at http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.634114 30652 scheduler.cpp:243] Sending SUBSCRIBE call to
>> http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.643971 30652 slave.cpp:1008] Authenticating with master
>> master@172.17.0.2:41689
>> I0625 05:38:36.644138 30652 slave.cpp:1019] Using default CRAM-MD5
>> authenticatee
>> I0625 05:38:36.644603 30649 authenticatee.cpp:121] Creating new client
>> SASL connection
>> I0625 05:38:36.645187 30649 master.cpp:7640] Authenticating slave(602)@
>> 172.17.0.2:41689
>> I0625 05:38:36.645732 30647 authenticator.cpp:414] Starting
>> authentication session for crammd5-authenticatee(1214)@172.17.0.2:41689
>> I0625 05:38:36.646189 30648 authenticator.cpp:98] Creating new server
>> SASL connection
>> I0625 05:38:36.646958 30648 authenticatee.cpp:213] Received SASL
>> authentication mechanisms: CRAM-MD5
>> I0625 05:38:36.647043 30648 authenticatee.cpp:239] Attempting to
>> authenticate with mechanism 'CRAM-MD5'
>> I0625 05:38:36.647383 30650 process.cpp:3779] Handling HTTP event for
>> process 'master' with path: '/master/api/v1/scheduler'
>> I0625 05:38:36.647814 30651 authenticator.cpp:204] Received SASL
>> authentication start
>> I0625 05:38:36.648041 30651 authenticator.cpp:326] Authentication
>> requires more steps
>> I0625 05:38:36.648303 30651 authenticatee.cpp:259] Received SASL
>> authentication step
>> I0625 05:38:36.648571 30651 authenticator.cpp:232] Received SASL
>> authentication step
>> I0625 05:38:36.648775 30651 auxprop.cpp:109] Request to lookup properties
>> for user: 'test-principal' realm: '7bd48084f726' server FQDN:
>> '7bd48084f726' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
>> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
>> I0625 05:38:36.650660 30651 auxprop.cpp:181] Looking up auxiliary
>> property '*userPassword'
>> I0625 05:38:36.650904 30651 auxprop.cpp:181] Looking up auxiliary
>> property '*cmusaslsecretCRAM-MD5'
>> I0625 05:38:36.651036 30651 auxprop.cpp:109] Request to lookup properties
>> for user: 'test-principal' realm: '7bd48084f726' server FQDN:
>> '7bd48084f726' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
>> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
>> I0625 05:38:36.651201 30651 auxprop.cpp:131] Skipping auxiliary property
>> '*userPassword' since SASL_AUXPROP_AUTHZID == true
>> I0625 05:38:36.651324 30651 auxprop.cpp:131] Skipping auxiliary property
>> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
>> I0625 05:38:36.650538 30648 http.cpp:1114] HTTP POST for
>> /master/api/v1/scheduler from 172.17.0.2:59018
>> I0625 05:38:36.652107 30648 master.cpp:2514] Received subscription
>> request for HTTP framework 'default'
>> I0625 05:38:36.652154 30651 authenticator.cpp:318] Authentication success
>> I0625 05:38:36.652767 30651 authenticatee.cpp:299] Authentication success
>> I0625 05:38:36.653141 30649 authenticator.cpp:432] Authentication session
>> cleanup for crammd5-authenticatee(1214)@172.17.0.2:41689
>> I0625 05:38:36.653182 30648 master.cpp:2197] Authorizing framework
>> principal 'test-principal' to receive offers for roles '{ * }'
>> I0625 05:38:36.656334 30651 slave.cpp:1103] Successfully authenticated
>> with master master@172.17.0.2:41689
>> I0625 05:38:36.657078 30648 master.cpp:7670] Successfully authenticated
>> principal 'test-principal' at slave(602)@172.17.0.2:41689
>> I0625 05:38:36.657861 30648 master.cpp:2650] Subscribing framework
>> 'default' with checkpointing disabled and capabilities [
>> RESERVATION_REFINEMENT ]
>> I0625 05:38:36.660224 30651 slave.cpp:1545] Will retry registration in
>> 13.830504ms if necessary
>> I0625 05:38:36.661294 30648 master.cpp:5602] Received register agent
>> message from slave(602)@172.17.0.2:41689 (7bd48084f726)
>> I0625 05:38:36.662750 30648 master.cpp:3742] Authorizing agent with
>> principal 'test-principal'
>> I0625 05:38:36.663457 30651 hierarchical.cpp:301] Added framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.667315 30651 hierarchical.cpp:1938] No allocations
>> performed
>> I0625 05:38:36.667415 30651 hierarchical.cpp:2028] No inverse offers to
>> send out!
>> I0625 05:38:36.667028 30649 scheduler.cpp:676] Enqueuing event SUBSCRIBED
>> received from http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.664041 30648 master.hpp:2216] Sending heartbeat to
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.666292 30652 master.cpp:5662] Authorized registration of
>> agent at slave(602)@172.17.0.2:41689 (7bd48084f726)
>> I0625 05:38:36.669510 30652 master.cpp:5741] Registering agent at
>> slave(602)@172.17.0.2:41689 (7bd48084f726) with id
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
>> I0625 05:38:36.670693 30649 registrar.cpp:493] Applied 1 operations in
>> 130659ns; attempting to update the registry
>> I0625 05:38:36.671162 30651 hierarchical.cpp:1493] Performed allocation
>> for 0 agents in 3.925187ms
>> I0625 05:38:36.672591 30649 registrar.cpp:550] Successfully updated the
>> registry in 1.688064ms
>> I0625 05:38:36.673195 30649 master.cpp:5788] Admitted agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726)
>> I0625 05:38:36.674314 30649 master.cpp:5819] Registered agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726) with [{"name":"cpus","scalar":{"val
>> ue":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":
>> 1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":
>> 1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[
>> {"begin":31000,"end":32000}]},"type":"RANGES"}]
>> I0625 05:38:36.675292 30653 slave.cpp:1149] Registered with master
>> master@172.17.0.2:41689; given agent ID 8cc81eb7-c434-4f01-9a47-dbd00f
>> 156777-S0
>> I0625 05:38:36.675674 30650 hierarchical.cpp:587] Added agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 (7bd48084f726) with cpus:2;
>> mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
>> I0625 05:38:36.676200 30648 status_update_manager.cpp:184] Resuming
>> sending status updates
>> I0625 05:38:36.675828 30651 scheduler.cpp:676] Enqueuing event HEARTBEAT
>> received from http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.676854 30653 slave.cpp:1169] Checkpointing SlaveInfo to
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/meta/
>> slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/slave.info'
>> I0625 05:38:36.677603 30653 slave.cpp:1207] Forwarding total
>> oversubscribed resources {}
>> I0625 05:38:36.680416 30653 slave.cpp:4866] Received ping from
>> slave-observer(580)@172.17.0.2:41689
>> I0625 05:38:36.680806 30651 master.cpp:6508] Received update of agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726) with total oversubscribed resources {}
>> I0625 05:38:36.680874 30650 hierarchical.cpp:2028] No inverse offers to
>> send out!
>> I0625 05:38:36.681049 30650 hierarchical.cpp:1493] Performed allocation
>> for 1 agents in 4.532396ms
>> I0625 05:38:36.682137 30651 master.cpp:7470] Sending 1 offers to
>> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
>> I0625 05:38:36.689234 30648 scheduler.cpp:676] Enqueuing event OFFERS
>> received from http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.717994 30649 process.cpp:3779] Handling HTTP event for process
>> 'master' with path: '/master/api/v1'
>> I0625 05:38:36.723136 30648 http.cpp:1114] HTTP POST for /master/api/v1
>> from 172.17.0.2:59022
>> I0625 05:38:36.723544 30648 http.cpp:539] Processing call SUBSCRIBE
>> I0625 05:38:36.725697 30648 master.cpp:9409] Added subscriber:
>> 56101e34-8252-4ab5-ad4c-e17f0e65ebc2 to the list of active subscribers
>> I0625 05:38:36.744335 30647 scheduler.cpp:243] Sending ACCEPT call to
>> http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.748258 30648 process.cpp:3779] Handling HTTP event for process
>> 'master' with path: '/master/api/v1/scheduler'
>> I0625 05:38:36.750792 30648 http.cpp:1114] HTTP POST for
>> /master/api/v1/scheduler from 172.17.0.2:59020
>> I0625 05:38:36.752667 30648 master.cpp:3957] Processing ACCEPT call for
>> offers: [ 8cc81eb7-c434-4f01-9a47-dbd00f156777-O0 ] on agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726) for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> (default)
>> I0625 05:38:36.752985 30648 master.cpp:3469] Authorizing framework
>> principal 'test-principal' to launch task f653890f-85d4-42bc-bc2c-92f535
>> f0dad1
>> W0625 05:38:36.767402 30647 validation.cpp:1294] Executor 'default' for
>> task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' uses less CPUs (None) than
>> the minimum required (0.01). Please update your executor, as this will be
>> mandatory in future releases.
>> W0625 05:38:36.767468 30647 validation.cpp:1306] Executor 'default' for
>> task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' uses less memory (None) than
>> the minimum required (32MB). Please update your executor, as this will be
>> mandatory in future releases.
>> I0625 05:38:36.768510 30647 master.cpp:9387] Notifying all active
>> subscribers about TASK_ADDED event
>> I0625 05:38:36.768996 30647 master.cpp:9518] Adding task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 with resources
>> [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"va
>> lue":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},
>> "name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"
>> allocation_info":{"role":"*"},"name":"disk","scalar":{"value
>> ":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},
>> "name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
>> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
>> 172.17.0.2:41689 (7bd48084f726)
>> I0625 05:38:36.770148 30647 master.cpp:4684] Launching task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) with resources
>> [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"va
>> lue":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},
>> "name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"
>> allocation_info":{"role":"*"},"name":"disk","scalar":{"value
>> ":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},
>> "name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
>> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
>> 172.17.0.2:41689 (7bd48084f726)
>> I0625 05:38:36.771541 30653 slave.cpp:1670] Got assigned task
>> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.772871 30653 slave.cpp:1951] Authorizing task
>> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.772992 30653 slave.cpp:6667] Authorizing framework
>> principal 'test-principal' to launch task f653890f-85d4-42bc-bc2c-92f535
>> f0dad1
>> I0625 05:38:36.775192 30647 hierarchical.cpp:912] Updated allocation of
>> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 from cpus(allocated: *):2;
>> mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated:
>> *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):1024;
>> disk(allocated: *):1024; ports(allocated: *):[31000-32000]
>> I0625 05:38:36.775754 30650 slave.cpp:2138] Launching task
>> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.776747 30650 paths.cpp:577] Trying to chown
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/
>> default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51' to user 'mesos'
>> I0625 05:38:36.777156 30650 slave.cpp:7127] Launching executor 'default'
>> of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 with resources []
>> in work directory '/tmp/ContentType_MasterAPITes
>> t_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-
>> dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-
>> dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-
>> 4f06-b210-e83704f05e51'
>> I0625 05:38:36.778022 30650 slave.cpp:2833] Launching container
>> 1dbd3c1f-3f2a-4f06-b210-e83704f05e51 for executor 'default' of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.778846 30650 slave.cpp:2367] Queued task
>> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for executor 'default' of
>> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.779094 30650 slave.cpp:899] Successfully attached file
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/
>> default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
>> I0625 05:38:36.779170 30650 slave.cpp:899] Successfully attached file
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/
>> default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
>> I0625 05:38:36.782416 30651 executor.cpp:192] Version: 1.4.0
>> I0625 05:38:36.794209 30654 executor.cpp:410] Connected with the agent
>> I0625 05:38:36.799077 30654 executor.cpp:307] Sending SUBSCRIBE call to
>> http://172.17.0.2:41689/slave(602)/api/v1/executor
>> I0625 <http://172.17.0.2:41689/slave(602)/api/v1/executorI0625>
>> 05:38:36.807615 30649 process.cpp:3779] Handling HTTP event for process
>> 'slave(602)' with path: '/slave(602)/api/v1/executor'
>> I0625 05:38:36.810356 30649 http.cpp:1114] HTTP POST for
>> /slave(602)/api/v1/executor from 172.17.0.2:59024
>> I0625 05:38:36.810880 30649 slave.cpp:3650] Received Subscribe request
>> for HTTP executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f
>> 156777-0000
>> I0625 05:38:36.814677 30649 slave.cpp:2580] Sending queued task
>> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' to executor 'default' of
>> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via HTTP)
>> I0625 05:38:36.821112 30649 executor.cpp:725] Enqueuing event SUBSCRIBED
>> received from http://172.17.0.2:41689/slave(602)/api/v1/executor
>> I0625 <http://172.17.0.2:41689/slave(602)/api/v1/executorI0625>
>> 05:38:36.824698 30652 executor.cpp:725] Enqueuing event LAUNCH received
>> from http://172.17.0.2:41689/slave(602)/api/v1/executor
>> I0625 <http://172.17.0.2:41689/slave(602)/api/v1/executorI0625>
>> 05:38:36.835325 30652 executor.cpp:307] Sending UPDATE call to
>> http://172.17.0.2:41689/slave(602)/api/v1/executor
>> I0625 <http://172.17.0.2:41689/slave(602)/api/v1/executorI0625>
>> 05:38:36.854226 30652 process.cpp:3779] Handling HTTP event for process
>> 'slave(602)' with path: '/slave(602)/api/v1/executor'
>> I0625 05:38:36.856245 30648 http.cpp:1114] HTTP POST for
>> /slave(602)/api/v1/executor from 172.17.0.2:59026
>> I0625 05:38:36.856809 30648 slave.cpp:4336] Handling status update
>> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.858875 30653 status_update_manager.cpp:323] Received
>> status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8)
>> for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.858964 30653 status_update_manager.cpp:500] Creating
>> StatusUpdate stream for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of
>> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.859845 30653 status_update_manager.cpp:377] Forwarding
>> update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for
>> task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to the agent
>> I0625 05:38:36.860874 30653 slave.cpp:4776] Forwarding the update
>> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to master@172.17.0.2:41689
>> I0625 05:38:36.861451 30653 slave.cpp:4670] Status update manager
>> successfully handled status update TASK_RUNNING (UUID:
>> f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.862102 30654 master.cpp:6653] Status update TASK_RUNNING
>> (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 from agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726)
>> I0625 05:38:36.862200 30654 master.cpp:6715] Forwarding status update
>> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.863239 30654 master.cpp:9387] Notifying all active
>> subscribers about TASK_UPDATED event
>> I0625 05:38:36.864557 30654 master.cpp:8731] Updating the state of task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (latest state: TASK_RUNNING,
>> status update state: TASK_RUNNING)
>> I0625 05:38:36.866746 30654 scheduler.cpp:676] Enqueuing event UPDATE
>> received from http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.867503 30653 executor.cpp:725] Enqueuing event ACKNOWLEDGED
>> received from http://172.17.0.2:41689/slave(602)/api/v1/executor
>> I0625 <http://172.17.0.2:41689/slave(602)/api/v1/executorI0625>
>> 05:38:36.899293 30654 hierarchical.cpp:1938] No allocations performed
>> I0625 05:38:36.899372 30654 hierarchical.cpp:2028] No inverse offers to
>> send out!
>> I0625 05:38:36.899749 30654 hierarchical.cpp:1493] Performed allocation
>> for 1 agents in 682189ns
>> W0625 05:38:36.899785 30650 status_update_manager.cpp:478] Resending
>> status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8)
>> for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.899863 30650 status_update_manager.cpp:377] Forwarding
>> update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for
>> task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to the agent
>> I0625 05:38:36.900494 30651 slave.cpp:4776] Forwarding the update
>> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to master@172.17.0.2:41689
>> I0625 05:38:36.901358 30653 master.cpp:6653] Status update TASK_RUNNING
>> (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 from agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726)
>> I0625 05:38:36.901551 30653 master.cpp:6715] Forwarding status update
>> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.902580 30653 master.cpp:8731] Updating the state of task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (latest state: TASK_RUNNING,
>> status update state: TASK_RUNNING)
>> I0625 05:38:36.909910 30651 scheduler.cpp:676] Enqueuing event UPDATE
>> received from http://172.17.0.2:41689/master/api/v1/scheduler
>> I0625 <http://172.17.0.2:41689/master/api/v1/schedulerI0625>
>> 05:38:36.919378 30649 master.cpp:1430] Framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) disconnected
>> I0625 05:38:36.919478 30649 master.cpp:3203] Deactivating framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
>> I0625 05:38:36.919668 30649 master.cpp:3180] Disconnecting framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
>> I0625 05:38:36.919744 30649 master.cpp:1445] Giving framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) 0ns to failover
>> I0625 05:38:36.919906 30650 hierarchical.cpp:410] Deactivated framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.927209 30647 master.cpp:7306] Framework failover timeout,
>> removing framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
>> I0625 05:38:36.927266 30647 master.cpp:8163] Removing framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
>> I0625 05:38:36.944106 30647 master.cpp:9387] Notifying all active
>> subscribers about TASK_UPDATED event
>> I0625 05:38:36.944474 30647 master.cpp:8731] Updating the state of task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (latest state: TASK_KILLED,
>> status update state: TASK_KILLED)
>> I0625 05:38:36.945756 30647 master.cpp:8825] Removing task
>> f653890f-85d4-42bc-bc2c-92f535f0dad1 with resources
>> [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"va
>> lue":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},
>> "name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"
>> allocation_info":{"role":"*"},"name":"disk","scalar":{"value
>> ":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},
>> "name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
>> of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726)
>> I0625 05:38:36.946652 30647 master.cpp:8854] Removing executor 'default'
>> with resources [] of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
>> 172.17.0.2:41689 (7bd48084f726)
>> I0625 05:38:36.947301 30647 slave.cpp:3136] Asked to shut down framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 by master@172.17.0.2:41689
>> I0625 05:38:36.947362 30647 slave.cpp:3161] Shutting down framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.947497 30647 slave.cpp:5631] Shutting down executor
>> 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via
>> HTTP)
>> I0625 05:38:36.955519 30652 hierarchical.cpp:1177] Recovered
>> cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024;
>> ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024;
>> ports:[31000-32000], allocated: {}) on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
>> from framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.956034 30652 hierarchical.cpp:353] Removed framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.973021 30653 executor.cpp:725] Enqueuing event SHUTDOWN
>> received from http://172.17.0.2:41689/slave(602)/api/v1/executor
>> I0625 <http://172.17.0.2:41689/slave(602)/api/v1/executorI0625>
>> 05:38:36.979570 30649 slave.cpp:5309] Executor 'default' of framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 exited with status 0
>> I0625 05:38:36.980602 30649 slave.cpp:5409] Cleaning up executor
>> 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via
>> HTTP)
>> W0625 05:38:36.980964 30648 master.cpp:6770] Ignoring unknown exited
>> executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
>> 172.17.0.2:41689 (7bd48084f726)
>> I0625 05:38:36.982070 30649 slave.cpp:5505] Cleaning up framework
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.982441 30650 gc.cpp:55] Scheduling
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/
>> default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51' for gc
>> 6.99998976679407days in the future
>> I0625 05:38:36.982753 30654 status_update_manager.cpp:285] Closing status
>> update streams for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.982821 30650 gc.cpp:55] Scheduling
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default' for gc
>> 6.99998976679407days in the future
>> I0625 05:38:36.983003 30654 status_update_manager.cpp:531] Cleaning up
>> status update stream for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of
>> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
>> I0625 05:38:36.983212 30650 gc.cpp:55] Scheduling
>> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000' for gc 6.99998976679407days
>> in the future
>> I0625 05:38:36.984166 30646 slave.cpp:818] Agent terminating
>> I0625 05:38:36.984511 30650 master.cpp:1316] Agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726) disconnected
>> I0625 05:38:36.984555 30650 master.cpp:3240] Disconnecting agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726)
>> I0625 05:38:36.984851 30650 master.cpp:3259] Deactivating agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
>> (7bd48084f726)
>> I0625 05:38:36.986714 30648 hierarchical.cpp:715] Agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 deactivated
>> I0625 05:38:36.995141 30646 master.cpp:1158] Master terminating
>> I0625 05:38:36.998049 30651 hierarchical.cpp:620] Removed agent
>> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
>> [ OK ] ContentType/MasterAPITest.Subscribe/0 (448 ms)
>> [ RUN ] ContentType/MasterAPITest.Subscribe/1
>> I0625 05:38:37.009217 30646 cluster.cpp:162] Creating default 'local'
>> authorizer
>> I0625 05:38:37.014230 30650 master.cpp:438] Master
>> 7395bba4-e83c-4a4a-9010-d2e89629edeb (7bd48084f726) started on
>> 172.17.0.2:41689
>> I0625 05:38:37.014291 30650 master.cpp:440] Flags at startup: --acls=""
>> --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
>> --allocation_interval="1secs" --allocator="HierarchicalDRF"
>> --authenticate_agents="true" --authenticate_frameworks="true"
>> --authenticate_http_frameworks="true" --authenticate_http_readonly="true"
>> --authenticate_http_readwrite="true" --authenticators="crammd5"
>> --authorizers="local" --credentials="/tmp/D1sbIK/credentials"
>> --filter_gpu_resources="true" --framework_sorter="drf" --help="false"
>> --hostname_lookup="true" --http_authenticators="basic"
>> --http_framework_authenticators="basic" --initialize_driver_logging="true"
>> --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO"
>> --max_agent_ping_timeouts="5" --max_completed_frameworks="50"
>> --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000"
>> --port="5050" --quiet="false" --recovery_agent_removal_limit="100%"
>> --registry="in_memory" --registry_fetch_timeout="1mins"
>> --registry_gc_interval="15mins" --registry_max_agent_age="2weeks"
>> --registry_max_agent_count="102400" --registry_store_timeout="100secs"
>> --registry_strict="false" --root_submissions="true" --user_sorter="drf"
>> --version="false" --webui_dir="/usr/local/share/mesos/webui"
>> --work_dir="/tmp/D1sbIK/master" --zk_session_timeout="10secs"
>> I0625 05:38:37.014972 30650 master.cpp:490] Master only allowing
>> authenticated frameworks to register
>> I0625 05:38:37.014992 30650 master.cpp:504] Master only allowing
>> authenticated agents to register
>> I0625 05:38:37.015008 30650 master.cpp:517] Master only allowing
>> authenticated HTTP frameworks to register
>> I0625 05:38:37.015019 30650 credentials.hpp:37] Loading credentials for
>> authentication from '/tmp/D1sbIK/credentials'
>> I0625 05:38:37.015575 30650 master.cpp:562] Using default 'crammd5'
>> authenticator
>> I0625 05:38:37.016842 30650 http.cpp:974] Creating default 'basic' HTTP
>> authenticator for realm 'mesos-master-readonly'
>> I0625 05:38:37.017230 30650 http.cpp:974] Creating default 'basic' HTTP
>> authenticator for realm 'mesos-master-readwrite'
>> I0625 05:38:37.017542 30650 http.cpp:974] Creating default 'basic' HTTP
>> authenticator for realm 'mesos-master-scheduler'
>> I0625 05:38:37.017822 30650 master.cpp:642] Authorization enabled
>> I0625 05:38:37.018196 30651 hierarchical.cpp:169] Initialized
>> hierarchical allocator process
>> I0625 05:38:37.018357 30653 whitelist_watcher.cpp:77] No whitelist given
>> *** Aborted at 1498369117 (unix time) try "date -d @1498369117" if you
>> are using GNU date ***
>> PC: @ 0x2b0f5603bc41 std::_Hashtable<>::_M_bucket_begin()
>> *** SIGSEGV (@0x5d0) received by PID 30646 (TID 0x2b0f641b6700) from PID
>> 1488; stack trace: ***
>> @ 0x2b0f5bfcc330 (unknown)
>> @ 0x2b0f5603bc41 std::_Hashtable<>::_M_bucket_begin()
>> @ 0x2b0f5603bb2d std::_Hashtable<>::count()
>> @ 0x2b0f5603bacd std::unordered_map<>::count()
>> @ 0x2b0f56033b68 hashmap<>::contains()
>> @ 0x2b0f56008d5e mesos::internal::master::Master::exited()
>> @ 0x2b0f5600aeaa mesos::internal::master::Maste
>> r::subscribe()::$_36::operator()()
>> @ 0x2b0f5600ae71 _ZZZNK7process9_DeferredIZN5me
>> sos8internal6master6Master9subscribeERKNS3_14HttpConnectionE
>> E4$_36EcvSt8functionIFvT_EEIRKNS_6FutureI7NothingEEEEvE
>> NKUlSJ_E_clESJ_ENKUlvE_clEv
>> @ 0x2b0f5600abdd _ZNSt17_Function_handlerIFvvEZ
>> ZNK7process9_DeferredIZN5mesos8internal6master6Master9subscr
>> ibeERKNS5_14HttpConnectionEE4$_36EcvSt8functionIFvT_
>> EEIRKNS1_6FutureI7NothingEEEEvENKUlSL_E_clESL_EUlvE_E9_M_inv
>> okeERKSt9_Any_data
>> @ 0x1af707e std::function<>::operator()()
>> @ 0x1eabc09 _ZZN7process8internal8Dispatch
>> IvEclIRSt8functionIFvvEEEEvRKNS_4UPIDEOT_ENKUlPNS_11ProcessBaseEE_clESE_
>> @ 0x1eab9c2 _ZNSt17_Function_handlerIFvPN7
>> process11ProcessBaseEEZNS0_8internal8DispatchIvEclIRSt8funct
>> ionIFvvEEEEvRKNS0_4UPIDEOT_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
>> @ 0x2b0f582e7608 std::function<>::operator()()
>> @ 0x2b0f582cdab4 process::ProcessBase::visit()
>> @ 0x2b0f5835da8e process::DispatchEvent::visit()
>> @ 0x1af66b1 process::ProcessBase::serve()
>> @ 0x2b0f582cb7a4 process::ProcessManager::resume()
>> @ 0x2b0f582d982c process::ProcessManager::init_
>> threads()::$_2::operator()()
>> @ 0x2b0f582d9735 _ZNSt12_Bind_simpleIFZN7proces
>> s14ProcessManager12init_threadsEvE3$_2vEE9_M_
>> invokeIJEEEvSt12_Index_tupleIJXspT_EEE
>> @ 0x2b0f582d9705 std::_Bind_simple<>::operator()()
>> @ 0x2b0f582d96dc std::thread::_Impl<>::_M_run()
>> @ 0x2b0f5c28ba60 (unknown)
>> @ 0x2b0f5bfc4184 start_thread
>> @ 0x2b0f5caf7ffd (unknown)
>> make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
>> make[3]: Leaving directory `/mesos/build'
>> make[2]: *** [CMakeFiles/check.dir/all] Error 2
>> make[2]: Leaving directory `/mesos/build'
>> make[1]: *** [CMakeFiles/check.dir/rule] Error 2
>> make: *** [check] Error 2
>> make[1]: Leaving directory `/mesos/build'
>> + docker rmi mesos-1498363601-23977
>> Untagged: mesos-1498363601-23977:latest
>> Deleted: sha256:69a9c6d568b2e43fb62381324064d1434184294ecab392dbc88fb
>> 2de491bf747
>> Deleted: sha256:68e95192931eec7d04f2494a2d3733c0eac594251a7bfdf805a9f
>> 69e2c3128df
>> Deleted: sha256:fbcba2775ff6158be9fd24cc366c15409c0e175746cc2f469288c
>> 286ae70758b
>> Deleted: sha256:201198362a1707643de3fbaa3dbcf9eb436c3f677a9de632bbf8d
>> 28ff4114633
>> Deleted: sha256:bf59e70358fa9d05938f1c3853aa7614718f3093d542954a97530
>> 4ac0ea4b65d
>> Deleted: sha256:744b507b989374a81b9850d5e46cba97a839190b7e68b96b637d2
>> e9157546266
>> Deleted: sha256:b8f97c1fdaa332dba9bc8336679d98670184f04d490b31bf2066b
>> 836d247b437
>> Deleted: sha256:298a0ab554c2f67c962100f2d985ccb84d1d3f08c5e67fc079b31
>> 64c8cf8f572
>> Deleted: sha256:00f1ad8a8dccd512e23e631188c73ea43c9dc366ba150bfecb00d
>> a67f59aa7c1
>> Deleted: sha256:826a684aaea66cb886668b58e018cf32b93f3864328018821a208
>> a5d8cd67980
>> Deleted: sha256:ca12057da3de091cef0eb10634c037c65da0d3fb5068b0a7e431b
>> 5651e22dc37
>> Deleted: sha256:fb1bf8e946d90f02a2decb69440ea933eb668c903805225159d7b
>> 23ea1de1a0c
>> Deleted: sha256:696d0069b5799e26952923e0e409c166ca2ff2c0b8df117d0c7fe
>> 5413f8a9558
>> Deleted: sha256:5002f748b6181055eac5f21143f59bc9213613e8d2dde4e0f059c
>> eef44ade37d
>> Deleted: sha256:9237f985cc692f10a5cced56070b8e792816171e391395021cce7
>> 7fb5c6919be
>> Deleted: sha256:c12927b22aff9de8e8c6510d815aa42509001210f9cca470d76f2
>> 56b4a3c31fb
>> Deleted: sha256:48439e177949514e27737efb221e816ebe7f7735ca292c0be0247
>> cc92e8737a7
>> Deleted: sha256:daeaca50fbe99a8b3c71a2a602cb6a1ee53209af5bf9acda90d9f
>> d09cb276e25
>> Deleted: sha256:60bdde00e4e66ceaea419290a11b6950e9e11165254449602d536
>> b00b794e384
>> Deleted: sha256:9726d7006b503cb563112c4a703f28cf0a2bf9689a768e76670a0
>> 6b7d5b19428
>> Deleted: sha256:32e100c23beb3173cceb91531b20c183f1eec73a52dc29e20d10b
>> d54c1715dae
>> Deleted: sha256:c3bdce64a50882990caf44acf8fc6237fe7d8e1be565c9f0f3812
>> fd0ef0442cf
>> Deleted: sha256:dcdbf3c58373df5f14037f4dcb8e8bc0855410be329d8b73c3420
>> 38411b26c7b
>> Deleted: sha256:b8b671ff1747383a42de137aa849ab1ba6c48a62b8b3d9d05779d
>> 6dd2c56733e
>> Build step 'Execute shell' marked build as failure
>> Not sending mail to unregistered user neil.conway@gmail.com
>>
>
>
Re: Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3836
Posted by Vinod Kone <vi...@apache.org>.
filed https://issues.apache.org/jira/browse/MESOS-5812
On Sat, Jun 24, 2017 at 10:38 PM, Apache Jenkins Server <
jenkins@builds.apache.org> wrote:
> See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=
> cmake,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_
> VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-
> us1)&&(!ubuntu-eu2)/3836/display/redirect?page=changes>
>
> Changes:
>
> [neil.conway] Documented the content of the `SlaveInfo.resources` field.
>
> [neil.conway] Documented resource format in agent <-> master protocol.
>
> [neil.conway] Added comment to master logic for downgrading checkpointed
> resources.
>
> [neil.conway] Added sanity check to resource downgrade on agent
> registration.
>
> [neil.conway] Avoided master crash on agent re-registration.
>
> [neil.conway] Avoided master crash on re-registration of old agents.
>
> [neil.conway] Updated comments and help text in mesos-execute.
>
> ------------------------------------------
> [...truncated 22.40 MB...]
> I0625 05:38:36.607939 30654 slave.cpp:249] Mesos agent started on (602)@
> 172.17.0.2:41689
> I0625 05:38:36.608008 30654 slave.cpp:250] Flags at startup: --acls=""
> --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/
> ContentType_MasterAPITest_Subscribe_0_7l7vGt/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/ContentType_MasterAPITest_Subscribe_0_7l7vGt/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/ContentType_MasterAPITest_
> Subscribe_0_7l7vGt/store/docker" --docker_volume_checkpoint_
> dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false"
> --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs"
> --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/
> ContentType_MasterAPITest_Subscribe_0_7l7vGt/fetch"
> --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks"
> --gc_disk_headroom="0.1" --hadoop_home="" --help="false"
> --hostname_lookup="true" --http_command_executor="false"
> --http_credentials="/tmp/ContentType_MasterAPITest_
> Subscribe_0_7l7vGt/http_credentials" --http_heartbeat_interval="30secs"
> --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem"
> --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0"
> --logging_level="INFO" --max_completed_executors_per_framework="150"
> --oversubscribed_resources_interval="15secs" --perf_duration="10secs"
> --perf_interval="1mins" --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/ContentType_MasterAPITest_Subscribe_0_7l7vGt"
> --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/ContentType_MasterAPITest_Subscribe_0_XhgpN3"
> I0625 05:38:36.609035 30654 credentials.hpp:86] Loading credential for
> authentication from '/tmp/ContentType_MasterAPITest_Subscribe_0_
> 7l7vGt/credential'
> I0625 05:38:36.609429 30654 slave.cpp:282] Agent using credential for:
> test-principal
> I0625 05:38:36.609463 30654 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/ContentType_MasterAPITest_Subscribe_0_
> 7l7vGt/http_credentials'
> I0625 05:38:36.609714 30646 scheduler.cpp:184] Version: 1.4.0
> I0625 05:38:36.610194 30654 http.cpp:974] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readonly'
> I0625 05:38:36.610607 30654 http.cpp:974] Creating default 'basic' HTTP
> authenticator for realm 'mesos-agent-readwrite'
> I0625 05:38:36.611371 30651 scheduler.cpp:470] New master detected at
> master@172.17.0.2:41689
> I0625 05:38:36.611460 30651 scheduler.cpp:479] Waiting for 0ns before
> initiating a re-(connection) attempt with the master
> I0625 05:38:36.613392 30654 slave.cpp:553] Agent resources:
> [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{
> "name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"
> name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"
> name":"ports","ranges":{"range":[{"begin":31000,"end":
> 32000}]},"type":"RANGES"}]
> I0625 05:38:36.613749 30654 slave.cpp:561] Agent attributes: [ ]
> I0625 05:38:36.613900 30654 slave.cpp:566] Agent hostname: 7bd48084f726
> I0625 05:38:36.614372 30651 status_update_manager.cpp:177] Pausing sending
> status updates
> I0625 05:38:36.617635 30654 state.cpp:64] Recovering state from
> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/meta'
> I0625 05:38:36.624533 30654 status_update_manager.cpp:203] Recovering
> status update manager
> I0625 05:38:36.625260 30652 slave.cpp:6168] Finished recovery
> I0625 05:38:36.626006 30652 slave.cpp:6350] Querying resource estimator
> for oversubscribable resources
> I0625 05:38:36.626371 30650 slave.cpp:6364] Received oversubscribable
> resources {} from the resource estimator
> I0625 05:38:36.626725 30650 slave.cpp:946] New master detected at
> master@172.17.0.2:41689
> I0625 05:38:36.626927 30650 slave.cpp:981] Detecting new master
> I0625 05:38:36.627110 30648 status_update_manager.cpp:177] Pausing sending
> status updates
> I0625 05:38:36.628080 30648 scheduler.cpp:361] Connected with the master
> at http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.634114 30652 scheduler.cpp:243] Sending SUBSCRIBE call to
> http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.643971 30652 slave.cpp:1008] Authenticating with master
> master@172.17.0.2:41689
> I0625 05:38:36.644138 30652 slave.cpp:1019] Using default CRAM-MD5
> authenticatee
> I0625 05:38:36.644603 30649 authenticatee.cpp:121] Creating new client
> SASL connection
> I0625 05:38:36.645187 30649 master.cpp:7640] Authenticating slave(602)@
> 172.17.0.2:41689
> I0625 05:38:36.645732 30647 authenticator.cpp:414] Starting authentication
> session for crammd5-authenticatee(1214)@172.17.0.2:41689
> I0625 05:38:36.646189 30648 authenticator.cpp:98] Creating new server SASL
> connection
> I0625 05:38:36.646958 30648 authenticatee.cpp:213] Received SASL
> authentication mechanisms: CRAM-MD5
> I0625 05:38:36.647043 30648 authenticatee.cpp:239] Attempting to
> authenticate with mechanism 'CRAM-MD5'
> I0625 05:38:36.647383 30650 process.cpp:3779] Handling HTTP event for
> process 'master' with path: '/master/api/v1/scheduler'
> I0625 05:38:36.647814 30651 authenticator.cpp:204] Received SASL
> authentication start
> I0625 05:38:36.648041 30651 authenticator.cpp:326] Authentication requires
> more steps
> I0625 05:38:36.648303 30651 authenticatee.cpp:259] Received SASL
> authentication step
> I0625 05:38:36.648571 30651 authenticator.cpp:232] Received SASL
> authentication step
> I0625 05:38:36.648775 30651 auxprop.cpp:109] Request to lookup properties
> for user: 'test-principal' realm: '7bd48084f726' server FQDN:
> '7bd48084f726' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
> I0625 05:38:36.650660 30651 auxprop.cpp:181] Looking up auxiliary property
> '*userPassword'
> I0625 05:38:36.650904 30651 auxprop.cpp:181] Looking up auxiliary property
> '*cmusaslsecretCRAM-MD5'
> I0625 05:38:36.651036 30651 auxprop.cpp:109] Request to lookup properties
> for user: 'test-principal' realm: '7bd48084f726' server FQDN:
> '7bd48084f726' SASL_AUXPROP_VERIFY_AGAINST_HASH: false
> SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
> I0625 05:38:36.651201 30651 auxprop.cpp:131] Skipping auxiliary property
> '*userPassword' since SASL_AUXPROP_AUTHZID == true
> I0625 05:38:36.651324 30651 auxprop.cpp:131] Skipping auxiliary property
> '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
> I0625 05:38:36.650538 30648 http.cpp:1114] HTTP POST for
> /master/api/v1/scheduler from 172.17.0.2:59018
> I0625 05:38:36.652107 30648 master.cpp:2514] Received subscription request
> for HTTP framework 'default'
> I0625 05:38:36.652154 30651 authenticator.cpp:318] Authentication success
> I0625 05:38:36.652767 30651 authenticatee.cpp:299] Authentication success
> I0625 05:38:36.653141 30649 authenticator.cpp:432] Authentication session
> cleanup for crammd5-authenticatee(1214)@172.17.0.2:41689
> I0625 05:38:36.653182 30648 master.cpp:2197] Authorizing framework
> principal 'test-principal' to receive offers for roles '{ * }'
> I0625 05:38:36.656334 30651 slave.cpp:1103] Successfully authenticated
> with master master@172.17.0.2:41689
> I0625 05:38:36.657078 30648 master.cpp:7670] Successfully authenticated
> principal 'test-principal' at slave(602)@172.17.0.2:41689
> I0625 05:38:36.657861 30648 master.cpp:2650] Subscribing framework
> 'default' with checkpointing disabled and capabilities [
> RESERVATION_REFINEMENT ]
> I0625 05:38:36.660224 30651 slave.cpp:1545] Will retry registration in
> 13.830504ms if necessary
> I0625 05:38:36.661294 30648 master.cpp:5602] Received register agent
> message from slave(602)@172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.662750 30648 master.cpp:3742] Authorizing agent with
> principal 'test-principal'
> I0625 05:38:36.663457 30651 hierarchical.cpp:301] Added framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.667315 30651 hierarchical.cpp:1938] No allocations performed
> I0625 05:38:36.667415 30651 hierarchical.cpp:2028] No inverse offers to
> send out!
> I0625 05:38:36.667028 30649 scheduler.cpp:676] Enqueuing event SUBSCRIBED
> received from http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.664041 30648 master.hpp:2216] Sending heartbeat to
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.666292 30652 master.cpp:5662] Authorized registration of
> agent at slave(602)@172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.669510 30652 master.cpp:5741] Registering agent at
> slave(602)@172.17.0.2:41689 (7bd48084f726) with id
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
> I0625 05:38:36.670693 30649 registrar.cpp:493] Applied 1 operations in
> 130659ns; attempting to update the registry
> I0625 05:38:36.671162 30651 hierarchical.cpp:1493] Performed allocation
> for 0 agents in 3.925187ms
> I0625 05:38:36.672591 30649 registrar.cpp:550] Successfully updated the
> registry in 1.688064ms
> I0625 05:38:36.673195 30649 master.cpp:5788] Admitted agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726)
> I0625 05:38:36.674314 30649 master.cpp:5819] Registered agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726) with [{"name":"cpus","scalar":{"
> value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value"
> :1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value"
> :1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"
> range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
> I0625 05:38:36.675292 30653 slave.cpp:1149] Registered with master
> master@172.17.0.2:41689; given agent ID 8cc81eb7-c434-4f01-9a47-
> dbd00f156777-S0
> I0625 05:38:36.675674 30650 hierarchical.cpp:587] Added agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 (7bd48084f726) with cpus:2;
> mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
> I0625 05:38:36.676200 30648 status_update_manager.cpp:184] Resuming
> sending status updates
> I0625 05:38:36.675828 30651 scheduler.cpp:676] Enqueuing event HEARTBEAT
> received from http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.676854 30653 slave.cpp:1169] Checkpointing SlaveInfo to
> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/meta/slaves/8cc81eb7-
> c434-4f01-9a47-dbd00f156777-S0/slave.info'
> I0625 05:38:36.677603 30653 slave.cpp:1207] Forwarding total
> oversubscribed resources {}
> I0625 05:38:36.680416 30653 slave.cpp:4866] Received ping from
> slave-observer(580)@172.17.0.2:41689
> I0625 05:38:36.680806 30651 master.cpp:6508] Received update of agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726) with total oversubscribed resources {}
> I0625 05:38:36.680874 30650 hierarchical.cpp:2028] No inverse offers to
> send out!
> I0625 05:38:36.681049 30650 hierarchical.cpp:1493] Performed allocation
> for 1 agents in 4.532396ms
> I0625 05:38:36.682137 30651 master.cpp:7470] Sending 1 offers to framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
> I0625 05:38:36.689234 30648 scheduler.cpp:676] Enqueuing event OFFERS
> received from http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.717994 30649 process.cpp:3779] Handling HTTP event for
> process 'master' with path: '/master/api/v1'
> I0625 05:38:36.723136 30648 http.cpp:1114] HTTP POST for /master/api/v1
> from 172.17.0.2:59022
> I0625 05:38:36.723544 30648 http.cpp:539] Processing call SUBSCRIBE
> I0625 05:38:36.725697 30648 master.cpp:9409] Added subscriber:
> 56101e34-8252-4ab5-ad4c-e17f0e65ebc2 to the list of active subscribers
> I0625 05:38:36.744335 30647 scheduler.cpp:243] Sending ACCEPT call to
> http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.748258 30648 process.cpp:3779] Handling HTTP event for
> process 'master' with path: '/master/api/v1/scheduler'
> I0625 05:38:36.750792 30648 http.cpp:1114] HTTP POST for
> /master/api/v1/scheduler from 172.17.0.2:59020
> I0625 05:38:36.752667 30648 master.cpp:3957] Processing ACCEPT call for
> offers: [ 8cc81eb7-c434-4f01-9a47-dbd00f156777-O0 ] on agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726) for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> (default)
> I0625 05:38:36.752985 30648 master.cpp:3469] Authorizing framework
> principal 'test-principal' to launch task f653890f-85d4-42bc-bc2c-
> 92f535f0dad1
> W0625 05:38:36.767402 30647 validation.cpp:1294] Executor 'default' for
> task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' uses less CPUs (None) than
> the minimum required (0.01). Please update your executor, as this will be
> mandatory in future releases.
> W0625 05:38:36.767468 30647 validation.cpp:1306] Executor 'default' for
> task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' uses less memory (None) than
> the minimum required (32MB). Please update your executor, as this will be
> mandatory in future releases.
> I0625 05:38:36.768510 30647 master.cpp:9387] Notifying all active
> subscribers about TASK_ADDED event
> I0625 05:38:36.768996 30647 master.cpp:9518] Adding task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 with resources
> [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"
> value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"}
> ,"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"
> },{"allocation_info":{"role":"*"},"name":"disk","scalar":{"
> value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"
> *"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
> 172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.770148 30647 master.cpp:4684] Launching task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> (default) with resources [{"allocation_info":{"role":"*
> "},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{
> "allocation_info":{"role":"*"},"name":"mem","scalar":{"
> value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"
> *"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"
> },{"allocation_info":{"role":"*"},"name":"ports","ranges":{"
> range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726)
> I0625 05:38:36.771541 30653 slave.cpp:1670] Got assigned task
> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.772871 30653 slave.cpp:1951] Authorizing task
> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.772992 30653 slave.cpp:6667] Authorizing framework
> principal 'test-principal' to launch task f653890f-85d4-42bc-bc2c-
> 92f535f0dad1
> I0625 05:38:36.775192 30647 hierarchical.cpp:912] Updated allocation of
> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 from cpus(allocated: *):2;
> mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated:
> *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):1024;
> disk(allocated: *):1024; ports(allocated: *):[31000-32000]
> I0625 05:38:36.775754 30650 slave.cpp:2138] Launching task
> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.776747 30650 paths.cpp:577] Trying to chown
> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-
> 4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-
> 9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
> to user 'mesos'
> I0625 05:38:36.777156 30650 slave.cpp:7127] Launching executor 'default'
> of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 with resources []
> in work directory '/tmp/ContentType_MasterAPITest_Subscribe_0_
> XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/
> frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/
> executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
> I0625 05:38:36.778022 30650 slave.cpp:2833] Launching container
> 1dbd3c1f-3f2a-4f06-b210-e83704f05e51 for executor 'default' of framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.778846 30650 slave.cpp:2367] Queued task
> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for executor 'default' of
> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.779094 30650 slave.cpp:899] Successfully attached file
> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-
> 4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-
> 9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-
> e83704f05e51'
> I0625 05:38:36.779170 30650 slave.cpp:899] Successfully attached file
> '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-
> 4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-
> 9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-
> e83704f05e51'
> I0625 05:38:36.782416 30651 executor.cpp:192] Version: 1.4.0
> I0625 05:38:36.794209 30654 executor.cpp:410] Connected with the agent
> I0625 05:38:36.799077 30654 executor.cpp:307] Sending SUBSCRIBE call to
> http://172.17.0.2:41689/slave(602)/api/v1/executor
> I0625 05:38:36.807615 30649 process.cpp:3779] Handling HTTP event for
> process 'slave(602)' with path: '/slave(602)/api/v1/executor'
> I0625 05:38:36.810356 30649 http.cpp:1114] HTTP POST for
> /slave(602)/api/v1/executor from 172.17.0.2:59024
> I0625 05:38:36.810880 30649 slave.cpp:3650] Received Subscribe request for
> HTTP executor 'default' of framework 8cc81eb7-c434-4f01-9a47-
> dbd00f156777-0000
> I0625 05:38:36.814677 30649 slave.cpp:2580] Sending queued task
> 'f653890f-85d4-42bc-bc2c-92f535f0dad1' to executor 'default' of framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via HTTP)
> I0625 05:38:36.821112 30649 executor.cpp:725] Enqueuing event SUBSCRIBED
> received from http://172.17.0.2:41689/slave(602)/api/v1/executor
> I0625 05:38:36.824698 30652 executor.cpp:725] Enqueuing event LAUNCH
> received from http://172.17.0.2:41689/slave(602)/api/v1/executor
> I0625 05:38:36.835325 30652 executor.cpp:307] Sending UPDATE call to
> http://172.17.0.2:41689/slave(602)/api/v1/executor
> I0625 05:38:36.854226 30652 process.cpp:3779] Handling HTTP event for
> process 'slave(602)' with path: '/slave(602)/api/v1/executor'
> I0625 05:38:36.856245 30648 http.cpp:1114] HTTP POST for
> /slave(602)/api/v1/executor from 172.17.0.2:59026
> I0625 05:38:36.856809 30648 slave.cpp:4336] Handling status update
> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-
> dbd00f156777-0000
> I0625 05:38:36.858875 30653 status_update_manager.cpp:323] Received status
> update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-
> dbd00f156777-0000
> I0625 05:38:36.858964 30653 status_update_manager.cpp:500] Creating
> StatusUpdate stream for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of
> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.859845 30653 status_update_manager.cpp:377] Forwarding
> update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> to the agent
> I0625 05:38:36.860874 30653 slave.cpp:4776] Forwarding the update
> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> to master@172.17.0.2:41689
> I0625 05:38:36.861451 30653 slave.cpp:4670] Status update manager
> successfully handled status update TASK_RUNNING (UUID:
> f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1
> of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.862102 30654 master.cpp:6653] Status update TASK_RUNNING
> (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> from agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
> 172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.862200 30654 master.cpp:6715] Forwarding status update
> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-
> dbd00f156777-0000
> I0625 05:38:36.863239 30654 master.cpp:9387] Notifying all active
> subscribers about TASK_UPDATED event
> I0625 05:38:36.864557 30654 master.cpp:8731] Updating the state of task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
> I0625 05:38:36.866746 30654 scheduler.cpp:676] Enqueuing event UPDATE
> received from http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.867503 30653 executor.cpp:725] Enqueuing event
> ACKNOWLEDGED received from http://172.17.0.2:41689/slave(
> 602)/api/v1/executor
> I0625 05:38:36.899293 30654 hierarchical.cpp:1938] No allocations
> performed
> I0625 05:38:36.899372 30654 hierarchical.cpp:2028] No inverse offers to
> send out!
> I0625 05:38:36.899749 30654 hierarchical.cpp:1493] Performed allocation
> for 1 agents in 682189ns
> W0625 05:38:36.899785 30650 status_update_manager.cpp:478] Resending
> status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8)
> for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.899863 30650 status_update_manager.cpp:377] Forwarding
> update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> to the agent
> I0625 05:38:36.900494 30651 slave.cpp:4776] Forwarding the update
> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> to master@172.17.0.2:41689
> I0625 05:38:36.901358 30653 master.cpp:6653] Status update TASK_RUNNING
> (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> from agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
> 172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.901551 30653 master.cpp:6715] Forwarding status update
> TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-
> dbd00f156777-0000
> I0625 05:38:36.902580 30653 master.cpp:8731] Updating the state of task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
> I0625 05:38:36.909910 30651 scheduler.cpp:676] Enqueuing event UPDATE
> received from http://172.17.0.2:41689/master/api/v1/scheduler
> I0625 05:38:36.919378 30649 master.cpp:1430] Framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) disconnected
> I0625 05:38:36.919478 30649 master.cpp:3203] Deactivating framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
> I0625 05:38:36.919668 30649 master.cpp:3180] Disconnecting framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
> I0625 05:38:36.919744 30649 master.cpp:1445] Giving framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) 0ns to failover
> I0625 05:38:36.919906 30650 hierarchical.cpp:410] Deactivated framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.927209 30647 master.cpp:7306] Framework failover timeout,
> removing framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
> I0625 05:38:36.927266 30647 master.cpp:8163] Removing framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
> I0625 05:38:36.944106 30647 master.cpp:9387] Notifying all active
> subscribers about TASK_UPDATED event
> I0625 05:38:36.944474 30647 master.cpp:8731] Updating the state of task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> (latest state: TASK_KILLED, status update state: TASK_KILLED)
> I0625 05:38:36.945756 30647 master.cpp:8825] Removing task
> f653890f-85d4-42bc-bc2c-92f535f0dad1 with resources
> [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"
> value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"}
> ,"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"
> },{"allocation_info":{"role":"*"},"name":"disk","scalar":{"
> value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"
> *"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
> of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726)
> I0625 05:38:36.946652 30647 master.cpp:8854] Removing executor 'default'
> with resources [] of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
> 172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.947301 30647 slave.cpp:3136] Asked to shut down framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 by master@172.17.0.2:41689
> I0625 05:38:36.947362 30647 slave.cpp:3161] Shutting down framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.947497 30647 slave.cpp:5631] Shutting down executor
> 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via
> HTTP)
> I0625 05:38:36.955519 30652 hierarchical.cpp:1177] Recovered
> cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024;
> ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024;
> ports:[31000-32000], allocated: {}) on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
> from framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.956034 30652 hierarchical.cpp:353] Removed framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.973021 30653 executor.cpp:725] Enqueuing event SHUTDOWN
> received from http://172.17.0.2:41689/slave(602)/api/v1/executor
> I0625 05:38:36.979570 30649 slave.cpp:5309] Executor 'default' of
> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 exited with status 0
> I0625 05:38:36.980602 30649 slave.cpp:5409] Cleaning up executor 'default'
> of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via HTTP)
> W0625 05:38:36.980964 30648 master.cpp:6770] Ignoring unknown exited
> executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@
> 172.17.0.2:41689 (7bd48084f726)
> I0625 05:38:36.982070 30649 slave.cpp:5505] Cleaning up framework
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.982441 30650 gc.cpp:55] Scheduling '/tmp/ContentType_
> MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-
> 4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-
> 9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
> for gc 6.99998976679407days in the future
> I0625 05:38:36.982753 30654 status_update_manager.cpp:285] Closing status
> update streams for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.982821 30650 gc.cpp:55] Scheduling '/tmp/ContentType_
> MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-
> 4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-
> 9a47-dbd00f156777-0000/executors/default' for gc 6.99998976679407days in
> the future
> I0625 05:38:36.983003 30654 status_update_manager.cpp:531] Cleaning up
> status update stream for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of
> framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
> I0625 05:38:36.983212 30650 gc.cpp:55] Scheduling '/tmp/ContentType_
> MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-
> 4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000'
> for gc 6.99998976679407days in the future
> I0625 05:38:36.984166 30646 slave.cpp:818] Agent terminating
> I0625 05:38:36.984511 30650 master.cpp:1316] Agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
> at slave(602)@172.17.0.2:41689 (7bd48084f726) disconnected
> I0625 05:38:36.984555 30650 master.cpp:3240] Disconnecting agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726)
> I0625 05:38:36.984851 30650 master.cpp:3259] Deactivating agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689
> (7bd48084f726)
> I0625 05:38:36.986714 30648 hierarchical.cpp:715] Agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 deactivated
> I0625 05:38:36.995141 30646 master.cpp:1158] Master terminating
> I0625 05:38:36.998049 30651 hierarchical.cpp:620] Removed agent
> 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
> [ OK ] ContentType/MasterAPITest.Subscribe/0 (448 ms)
> [ RUN ] ContentType/MasterAPITest.Subscribe/1
> I0625 05:38:37.009217 30646 cluster.cpp:162] Creating default 'local'
> authorizer
> I0625 05:38:37.014230 30650 master.cpp:438] Master 7395bba4-e83c-4a4a-9010-d2e89629edeb
> (7bd48084f726) started on 172.17.0.2:41689
> I0625 05:38:37.014291 30650 master.cpp:440] Flags at startup: --acls=""
> --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins"
> --allocation_interval="1secs" --allocator="HierarchicalDRF"
> --authenticate_agents="true" --authenticate_frameworks="true"
> --authenticate_http_frameworks="true" --authenticate_http_readonly="true"
> --authenticate_http_readwrite="true" --authenticators="crammd5"
> --authorizers="local" --credentials="/tmp/D1sbIK/credentials"
> --filter_gpu_resources="true" --framework_sorter="drf" --help="false"
> --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic"
> --initialize_driver_logging="true" --log_auto_initialize="true"
> --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5"
> --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000"
> --max_unreachable_tasks_per_framework="1000" --port="5050"
> --quiet="false" --recovery_agent_removal_limit="100%"
> --registry="in_memory" --registry_fetch_timeout="1mins"
> --registry_gc_interval="15mins" --registry_max_agent_age="2weeks"
> --registry_max_agent_count="102400" --registry_store_timeout="100secs"
> --registry_strict="false" --root_submissions="true" --user_sorter="drf"
> --version="false" --webui_dir="/usr/local/share/mesos/webui"
> --work_dir="/tmp/D1sbIK/master" --zk_session_timeout="10secs"
> I0625 05:38:37.014972 30650 master.cpp:490] Master only allowing
> authenticated frameworks to register
> I0625 05:38:37.014992 30650 master.cpp:504] Master only allowing
> authenticated agents to register
> I0625 05:38:37.015008 30650 master.cpp:517] Master only allowing
> authenticated HTTP frameworks to register
> I0625 05:38:37.015019 30650 credentials.hpp:37] Loading credentials for
> authentication from '/tmp/D1sbIK/credentials'
> I0625 05:38:37.015575 30650 master.cpp:562] Using default 'crammd5'
> authenticator
> I0625 05:38:37.016842 30650 http.cpp:974] Creating default 'basic' HTTP
> authenticator for realm 'mesos-master-readonly'
> I0625 05:38:37.017230 30650 http.cpp:974] Creating default 'basic' HTTP
> authenticator for realm 'mesos-master-readwrite'
> I0625 05:38:37.017542 30650 http.cpp:974] Creating default 'basic' HTTP
> authenticator for realm 'mesos-master-scheduler'
> I0625 05:38:37.017822 30650 master.cpp:642] Authorization enabled
> I0625 05:38:37.018196 30651 hierarchical.cpp:169] Initialized hierarchical
> allocator process
> I0625 05:38:37.018357 30653 whitelist_watcher.cpp:77] No whitelist given
> *** Aborted at 1498369117 (unix time) try "date -d @1498369117" if you are
> using GNU date ***
> PC: @ 0x2b0f5603bc41 std::_Hashtable<>::_M_bucket_begin()
> *** SIGSEGV (@0x5d0) received by PID 30646 (TID 0x2b0f641b6700) from PID
> 1488; stack trace: ***
> @ 0x2b0f5bfcc330 (unknown)
> @ 0x2b0f5603bc41 std::_Hashtable<>::_M_bucket_begin()
> @ 0x2b0f5603bb2d std::_Hashtable<>::count()
> @ 0x2b0f5603bacd std::unordered_map<>::count()
> @ 0x2b0f56033b68 hashmap<>::contains()
> @ 0x2b0f56008d5e mesos::internal::master::Master::exited()
> @ 0x2b0f5600aeaa mesos::internal::master::
> Master::subscribe()::$_36::operator()()
> @ 0x2b0f5600ae71 _ZZZNK7process9_DeferredIZN5mesos8internal6mas
> ter6Master9subscribeERKNS3_14HttpConnectionEE4$_
> 36EcvSt8functionIFvT_EEIRKNS_6FutureI7NothingEEEEvENKUlSJ_
> E_clESJ_ENKUlvE_clEv
> @ 0x2b0f5600abdd _ZNSt17_Function_handlerIFvvEZZNK7process9_
> DeferredIZN5mesos8internal6master6Master9subscribeERKNS5_
> 14HttpConnectionEE4$_36EcvSt8functionIFvT_EEIRKNS1_
> 6FutureI7NothingEEEEvENKUlSL_E_clESL_EUlvE_E9_M_invokeERKSt9_Any_data
> @ 0x1af707e std::function<>::operator()()
> @ 0x1eabc09 _ZZN7process8internal8DispatchI
> vEclIRSt8functionIFvvEEEEvRKNS_4UPIDEOT_ENKUlPNS_11ProcessBaseEE_clESE_
> @ 0x1eab9c2 _ZNSt17_Function_handlerIFvPN7process11ProcessB
> aseEEZNS0_8internal8DispatchIvEclIRSt8functionIFvvEEEEvRKNS0_4UPIDEOT_
> EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
> @ 0x2b0f582e7608 std::function<>::operator()()
> @ 0x2b0f582cdab4 process::ProcessBase::visit()
> @ 0x2b0f5835da8e process::DispatchEvent::visit()
> @ 0x1af66b1 process::ProcessBase::serve()
> @ 0x2b0f582cb7a4 process::ProcessManager::resume()
> @ 0x2b0f582d982c process::ProcessManager::init_
> threads()::$_2::operator()()
> @ 0x2b0f582d9735 _ZNSt12_Bind_simpleIFZN7process14ProcessMan
> ager12init_threadsEvE3$_2vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
> @ 0x2b0f582d9705 std::_Bind_simple<>::operator()()
> @ 0x2b0f582d96dc std::thread::_Impl<>::_M_run()
> @ 0x2b0f5c28ba60 (unknown)
> @ 0x2b0f5bfc4184 start_thread
> @ 0x2b0f5caf7ffd (unknown)
> make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
> make[3]: Leaving directory `/mesos/build'
> make[2]: *** [CMakeFiles/check.dir/all] Error 2
> make[2]: Leaving directory `/mesos/build'
> make[1]: *** [CMakeFiles/check.dir/rule] Error 2
> make: *** [check] Error 2
> make[1]: Leaving directory `/mesos/build'
> + docker rmi mesos-1498363601-23977
> Untagged: mesos-1498363601-23977:latest
> Deleted: sha256:69a9c6d568b2e43fb62381324064d1
> 434184294ecab392dbc88fb2de491bf747
> Deleted: sha256:68e95192931eec7d04f2494a2d3733
> c0eac594251a7bfdf805a9f69e2c3128df
> Deleted: sha256:fbcba2775ff6158be9fd24cc366c15
> 409c0e175746cc2f469288c286ae70758b
> Deleted: sha256:201198362a1707643de3fbaa3dbcf9
> eb436c3f677a9de632bbf8d28ff4114633
> Deleted: sha256:bf59e70358fa9d05938f1c3853aa76
> 14718f3093d542954a975304ac0ea4b65d
> Deleted: sha256:744b507b989374a81b9850d5e46cba
> 97a839190b7e68b96b637d2e9157546266
> Deleted: sha256:b8f97c1fdaa332dba9bc8336679d98
> 670184f04d490b31bf2066b836d247b437
> Deleted: sha256:298a0ab554c2f67c962100f2d985cc
> b84d1d3f08c5e67fc079b3164c8cf8f572
> Deleted: sha256:00f1ad8a8dccd512e23e631188c73e
> a43c9dc366ba150bfecb00da67f59aa7c1
> Deleted: sha256:826a684aaea66cb886668b58e018cf
> 32b93f3864328018821a208a5d8cd67980
> Deleted: sha256:ca12057da3de091cef0eb10634c037
> c65da0d3fb5068b0a7e431b5651e22dc37
> Deleted: sha256:fb1bf8e946d90f02a2decb69440ea9
> 33eb668c903805225159d7b23ea1de1a0c
> Deleted: sha256:696d0069b5799e26952923e0e409c1
> 66ca2ff2c0b8df117d0c7fe5413f8a9558
> Deleted: sha256:5002f748b6181055eac5f21143f59b
> c9213613e8d2dde4e0f059ceef44ade37d
> Deleted: sha256:9237f985cc692f10a5cced56070b8e
> 792816171e391395021cce77fb5c6919be
> Deleted: sha256:c12927b22aff9de8e8c6510d815aa4
> 2509001210f9cca470d76f256b4a3c31fb
> Deleted: sha256:48439e177949514e27737efb221e81
> 6ebe7f7735ca292c0be0247cc92e8737a7
> Deleted: sha256:daeaca50fbe99a8b3c71a2a602cb6a
> 1ee53209af5bf9acda90d9fd09cb276e25
> Deleted: sha256:60bdde00e4e66ceaea419290a11b69
> 50e9e11165254449602d536b00b794e384
> Deleted: sha256:9726d7006b503cb563112c4a703f28
> cf0a2bf9689a768e76670a06b7d5b19428
> Deleted: sha256:32e100c23beb3173cceb91531b20c1
> 83f1eec73a52dc29e20d10bd54c1715dae
> Deleted: sha256:c3bdce64a50882990caf44acf8fc62
> 37fe7d8e1be565c9f0f3812fd0ef0442cf
> Deleted: sha256:dcdbf3c58373df5f14037f4dcb8e8b
> c0855410be329d8b73c342038411b26c7b
> Deleted: sha256:b8b671ff1747383a42de137aa849ab
> 1ba6c48a62b8b3d9d05779d6dd2c56733e
> Build step 'Execute shell' marked build as failure
> Not sending mail to unregistered user neil.conway@gmail.com
>
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3836
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3836/display/redirect?page=changes>
Changes:
[neil.conway] Documented the content of the `SlaveInfo.resources` field.
[neil.conway] Documented resource format in agent <-> master protocol.
[neil.conway] Added comment to master logic for downgrading checkpointed resources.
[neil.conway] Added sanity check to resource downgrade on agent registration.
[neil.conway] Avoided master crash on agent re-registration.
[neil.conway] Avoided master crash on re-registration of old agents.
[neil.conway] Updated comments and help text in mesos-execute.
------------------------------------------
[...truncated 22.40 MB...]
I0625 05:38:36.607939 30654 slave.cpp:249] Mesos agent started on (602)@172.17.0.2:41689
I0625 05:38:36.608008 30654 slave.cpp:250] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/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/ContentType_MasterAPITest_Subscribe_0_7l7vGt/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/ContentType_MasterAPITest_Subscribe_0_7l7vGt/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_command_executor="false" --http_credentials="/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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/ContentType_MasterAPITest_Subscribe_0_7l7vGt" --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/ContentType_MasterAPITest_Subscribe_0_XhgpN3"
I0625 05:38:36.609035 30654 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/credential'
I0625 05:38:36.609429 30654 slave.cpp:282] Agent using credential for: test-principal
I0625 05:38:36.609463 30654 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_MasterAPITest_Subscribe_0_7l7vGt/http_credentials'
I0625 05:38:36.609714 30646 scheduler.cpp:184] Version: 1.4.0
I0625 05:38:36.610194 30654 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0625 05:38:36.610607 30654 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0625 05:38:36.611371 30651 scheduler.cpp:470] New master detected at master@172.17.0.2:41689
I0625 05:38:36.611460 30651 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0625 05:38:36.613392 30654 slave.cpp:553] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0625 05:38:36.613749 30654 slave.cpp:561] Agent attributes: [ ]
I0625 05:38:36.613900 30654 slave.cpp:566] Agent hostname: 7bd48084f726
I0625 05:38:36.614372 30651 status_update_manager.cpp:177] Pausing sending status updates
I0625 05:38:36.617635 30654 state.cpp:64] Recovering state from '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/meta'
I0625 05:38:36.624533 30654 status_update_manager.cpp:203] Recovering status update manager
I0625 05:38:36.625260 30652 slave.cpp:6168] Finished recovery
I0625 05:38:36.626006 30652 slave.cpp:6350] Querying resource estimator for oversubscribable resources
I0625 05:38:36.626371 30650 slave.cpp:6364] Received oversubscribable resources {} from the resource estimator
I0625 05:38:36.626725 30650 slave.cpp:946] New master detected at master@172.17.0.2:41689
I0625 05:38:36.626927 30650 slave.cpp:981] Detecting new master
I0625 05:38:36.627110 30648 status_update_manager.cpp:177] Pausing sending status updates
I0625 05:38:36.628080 30648 scheduler.cpp:361] Connected with the master at http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.634114 30652 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.643971 30652 slave.cpp:1008] Authenticating with master master@172.17.0.2:41689
I0625 05:38:36.644138 30652 slave.cpp:1019] Using default CRAM-MD5 authenticatee
I0625 05:38:36.644603 30649 authenticatee.cpp:121] Creating new client SASL connection
I0625 05:38:36.645187 30649 master.cpp:7640] Authenticating slave(602)@172.17.0.2:41689
I0625 05:38:36.645732 30647 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1214)@172.17.0.2:41689
I0625 05:38:36.646189 30648 authenticator.cpp:98] Creating new server SASL connection
I0625 05:38:36.646958 30648 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0625 05:38:36.647043 30648 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0625 05:38:36.647383 30650 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0625 05:38:36.647814 30651 authenticator.cpp:204] Received SASL authentication start
I0625 05:38:36.648041 30651 authenticator.cpp:326] Authentication requires more steps
I0625 05:38:36.648303 30651 authenticatee.cpp:259] Received SASL authentication step
I0625 05:38:36.648571 30651 authenticator.cpp:232] Received SASL authentication step
I0625 05:38:36.648775 30651 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7bd48084f726' server FQDN: '7bd48084f726' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0625 05:38:36.650660 30651 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0625 05:38:36.650904 30651 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0625 05:38:36.651036 30651 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7bd48084f726' server FQDN: '7bd48084f726' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0625 05:38:36.651201 30651 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0625 05:38:36.651324 30651 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0625 05:38:36.650538 30648 http.cpp:1114] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:59018
I0625 05:38:36.652107 30648 master.cpp:2514] Received subscription request for HTTP framework 'default'
I0625 05:38:36.652154 30651 authenticator.cpp:318] Authentication success
I0625 05:38:36.652767 30651 authenticatee.cpp:299] Authentication success
I0625 05:38:36.653141 30649 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1214)@172.17.0.2:41689
I0625 05:38:36.653182 30648 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0625 05:38:36.656334 30651 slave.cpp:1103] Successfully authenticated with master master@172.17.0.2:41689
I0625 05:38:36.657078 30648 master.cpp:7670] Successfully authenticated principal 'test-principal' at slave(602)@172.17.0.2:41689
I0625 05:38:36.657861 30648 master.cpp:2650] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
I0625 05:38:36.660224 30651 slave.cpp:1545] Will retry registration in 13.830504ms if necessary
I0625 05:38:36.661294 30648 master.cpp:5602] Received register agent message from slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.662750 30648 master.cpp:3742] Authorizing agent with principal 'test-principal'
I0625 05:38:36.663457 30651 hierarchical.cpp:301] Added framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.667315 30651 hierarchical.cpp:1938] No allocations performed
I0625 05:38:36.667415 30651 hierarchical.cpp:2028] No inverse offers to send out!
I0625 05:38:36.667028 30649 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.664041 30648 master.hpp:2216] Sending heartbeat to 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.666292 30652 master.cpp:5662] Authorized registration of agent at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.669510 30652 master.cpp:5741] Registering agent at slave(602)@172.17.0.2:41689 (7bd48084f726) with id 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
I0625 05:38:36.670693 30649 registrar.cpp:493] Applied 1 operations in 130659ns; attempting to update the registry
I0625 05:38:36.671162 30651 hierarchical.cpp:1493] Performed allocation for 0 agents in 3.925187ms
I0625 05:38:36.672591 30649 registrar.cpp:550] Successfully updated the registry in 1.688064ms
I0625 05:38:36.673195 30649 master.cpp:5788] Admitted agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.674314 30649 master.cpp:5819] Registered agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
I0625 05:38:36.675292 30653 slave.cpp:1149] Registered with master master@172.17.0.2:41689; given agent ID 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
I0625 05:38:36.675674 30650 hierarchical.cpp:587] Added agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 (7bd48084f726) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0625 05:38:36.676200 30648 status_update_manager.cpp:184] Resuming sending status updates
I0625 05:38:36.675828 30651 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.676854 30653 slave.cpp:1169] Checkpointing SlaveInfo to '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/meta/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/slave.info'
I0625 05:38:36.677603 30653 slave.cpp:1207] Forwarding total oversubscribed resources {}
I0625 05:38:36.680416 30653 slave.cpp:4866] Received ping from slave-observer(580)@172.17.0.2:41689
I0625 05:38:36.680806 30651 master.cpp:6508] Received update of agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726) with total oversubscribed resources {}
I0625 05:38:36.680874 30650 hierarchical.cpp:2028] No inverse offers to send out!
I0625 05:38:36.681049 30650 hierarchical.cpp:1493] Performed allocation for 1 agents in 4.532396ms
I0625 05:38:36.682137 30651 master.cpp:7470] Sending 1 offers to framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
I0625 05:38:36.689234 30648 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.717994 30649 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1'
I0625 05:38:36.723136 30648 http.cpp:1114] HTTP POST for /master/api/v1 from 172.17.0.2:59022
I0625 05:38:36.723544 30648 http.cpp:539] Processing call SUBSCRIBE
I0625 05:38:36.725697 30648 master.cpp:9409] Added subscriber: 56101e34-8252-4ab5-ad4c-e17f0e65ebc2 to the list of active subscribers
I0625 05:38:36.744335 30647 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.748258 30648 process.cpp:3779] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0625 05:38:36.750792 30648 http.cpp:1114] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:59020
I0625 05:38:36.752667 30648 master.cpp:3957] Processing ACCEPT call for offers: [ 8cc81eb7-c434-4f01-9a47-dbd00f156777-O0 ] on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726) for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
I0625 05:38:36.752985 30648 master.cpp:3469] Authorizing framework principal 'test-principal' to launch task f653890f-85d4-42bc-bc2c-92f535f0dad1
W0625 05:38:36.767402 30647 validation.cpp:1294] Executor 'default' for task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0625 05:38:36.767468 30647 validation.cpp:1306] Executor 'default' for task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0625 05:38:36.768510 30647 master.cpp:9387] Notifying all active subscribers about TASK_ADDED event
I0625 05:38:36.768996 30647 master.cpp:9518] Adding task f653890f-85d4-42bc-bc2c-92f535f0dad1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.770148 30647 master.cpp:4684] Launching task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.771541 30653 slave.cpp:1670] Got assigned task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.772871 30653 slave.cpp:1951] Authorizing task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.772992 30653 slave.cpp:6667] Authorizing framework principal 'test-principal' to launch task f653890f-85d4-42bc-bc2c-92f535f0dad1
I0625 05:38:36.775192 30647 hierarchical.cpp:912] Updated allocation of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 from cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] to cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000]
I0625 05:38:36.775754 30650 slave.cpp:2138] Launching task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.776747 30650 paths.cpp:577] Trying to chown '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51' to user 'mesos'
I0625 05:38:36.777156 30650 slave.cpp:7127] Launching executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 with resources [] in work directory '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
I0625 05:38:36.778022 30650 slave.cpp:2833] Launching container 1dbd3c1f-3f2a-4f06-b210-e83704f05e51 for executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.778846 30650 slave.cpp:2367] Queued task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' for executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.779094 30650 slave.cpp:899] Successfully attached file '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
I0625 05:38:36.779170 30650 slave.cpp:899] Successfully attached file '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51'
I0625 05:38:36.782416 30651 executor.cpp:192] Version: 1.4.0
I0625 05:38:36.794209 30654 executor.cpp:410] Connected with the agent
I0625 05:38:36.799077 30654 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.2:41689/slave(602)/api/v1/executor
I0625 05:38:36.807615 30649 process.cpp:3779] Handling HTTP event for process 'slave(602)' with path: '/slave(602)/api/v1/executor'
I0625 05:38:36.810356 30649 http.cpp:1114] HTTP POST for /slave(602)/api/v1/executor from 172.17.0.2:59024
I0625 05:38:36.810880 30649 slave.cpp:3650] Received Subscribe request for HTTP executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.814677 30649 slave.cpp:2580] Sending queued task 'f653890f-85d4-42bc-bc2c-92f535f0dad1' to executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via HTTP)
I0625 05:38:36.821112 30649 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.2:41689/slave(602)/api/v1/executor
I0625 05:38:36.824698 30652 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.2:41689/slave(602)/api/v1/executor
I0625 05:38:36.835325 30652 executor.cpp:307] Sending UPDATE call to http://172.17.0.2:41689/slave(602)/api/v1/executor
I0625 05:38:36.854226 30652 process.cpp:3779] Handling HTTP event for process 'slave(602)' with path: '/slave(602)/api/v1/executor'
I0625 05:38:36.856245 30648 http.cpp:1114] HTTP POST for /slave(602)/api/v1/executor from 172.17.0.2:59026
I0625 05:38:36.856809 30648 slave.cpp:4336] Handling status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.858875 30653 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.858964 30653 status_update_manager.cpp:500] Creating StatusUpdate stream for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.859845 30653 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to the agent
I0625 05:38:36.860874 30653 slave.cpp:4776] Forwarding the update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to master@172.17.0.2:41689
I0625 05:38:36.861451 30653 slave.cpp:4670] Status update manager successfully handled status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.862102 30654 master.cpp:6653] Status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 from agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.862200 30654 master.cpp:6715] Forwarding status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.863239 30654 master.cpp:9387] Notifying all active subscribers about TASK_UPDATED event
I0625 05:38:36.864557 30654 master.cpp:8731] Updating the state of task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0625 05:38:36.866746 30654 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.867503 30653 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:41689/slave(602)/api/v1/executor
I0625 05:38:36.899293 30654 hierarchical.cpp:1938] No allocations performed
I0625 05:38:36.899372 30654 hierarchical.cpp:2028] No inverse offers to send out!
I0625 05:38:36.899749 30654 hierarchical.cpp:1493] Performed allocation for 1 agents in 682189ns
W0625 05:38:36.899785 30650 status_update_manager.cpp:478] Resending status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.899863 30650 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to the agent
I0625 05:38:36.900494 30651 slave.cpp:4776] Forwarding the update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 to master@172.17.0.2:41689
I0625 05:38:36.901358 30653 master.cpp:6653] Status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 from agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.901551 30653 master.cpp:6715] Forwarding status update TASK_RUNNING (UUID: f39b842d-eb70-4ff2-bb47-de2057f830b8) for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.902580 30653 master.cpp:8731] Updating the state of task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0625 05:38:36.909910 30651 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:41689/master/api/v1/scheduler
I0625 05:38:36.919378 30649 master.cpp:1430] Framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) disconnected
I0625 05:38:36.919478 30649 master.cpp:3203] Deactivating framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
I0625 05:38:36.919668 30649 master.cpp:3180] Disconnecting framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
I0625 05:38:36.919744 30649 master.cpp:1445] Giving framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default) 0ns to failover
I0625 05:38:36.919906 30650 hierarchical.cpp:410] Deactivated framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.927209 30647 master.cpp:7306] Framework failover timeout, removing framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
I0625 05:38:36.927266 30647 master.cpp:8163] Removing framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (default)
I0625 05:38:36.944106 30647 master.cpp:9387] Notifying all active subscribers about TASK_UPDATED event
I0625 05:38:36.944474 30647 master.cpp:8731] Updating the state of task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0625 05:38:36.945756 30647 master.cpp:8825] Removing task f653890f-85d4-42bc-bc2c-92f535f0dad1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}] of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.946652 30647 master.cpp:8854] Removing executor 'default' with resources [] of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.947301 30647 slave.cpp:3136] Asked to shut down framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 by master@172.17.0.2:41689
I0625 05:38:36.947362 30647 slave.cpp:3161] Shutting down framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.947497 30647 slave.cpp:5631] Shutting down executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via HTTP)
I0625 05:38:36.955519 30652 hierarchical.cpp:1177] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: {}) on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 from framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.956034 30652 hierarchical.cpp:353] Removed framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.973021 30653 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.2:41689/slave(602)/api/v1/executor
I0625 05:38:36.979570 30649 slave.cpp:5309] Executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 exited with status 0
I0625 05:38:36.980602 30649 slave.cpp:5409] Cleaning up executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 (via HTTP)
W0625 05:38:36.980964 30648 master.cpp:6770] Ignoring unknown exited executor 'default' of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000 on agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.982070 30649 slave.cpp:5505] Cleaning up framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.982441 30650 gc.cpp:55] Scheduling '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default/runs/1dbd3c1f-3f2a-4f06-b210-e83704f05e51' for gc 6.99998976679407days in the future
I0625 05:38:36.982753 30654 status_update_manager.cpp:285] Closing status update streams for framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.982821 30650 gc.cpp:55] Scheduling '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000/executors/default' for gc 6.99998976679407days in the future
I0625 05:38:36.983003 30654 status_update_manager.cpp:531] Cleaning up status update stream for task f653890f-85d4-42bc-bc2c-92f535f0dad1 of framework 8cc81eb7-c434-4f01-9a47-dbd00f156777-0000
I0625 05:38:36.983212 30650 gc.cpp:55] Scheduling '/tmp/ContentType_MasterAPITest_Subscribe_0_XhgpN3/slaves/8cc81eb7-c434-4f01-9a47-dbd00f156777-S0/frameworks/8cc81eb7-c434-4f01-9a47-dbd00f156777-0000' for gc 6.99998976679407days in the future
I0625 05:38:36.984166 30646 slave.cpp:818] Agent terminating
I0625 05:38:36.984511 30650 master.cpp:1316] Agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726) disconnected
I0625 05:38:36.984555 30650 master.cpp:3240] Disconnecting agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.984851 30650 master.cpp:3259] Deactivating agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 at slave(602)@172.17.0.2:41689 (7bd48084f726)
I0625 05:38:36.986714 30648 hierarchical.cpp:715] Agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0 deactivated
I0625 05:38:36.995141 30646 master.cpp:1158] Master terminating
I0625 05:38:36.998049 30651 hierarchical.cpp:620] Removed agent 8cc81eb7-c434-4f01-9a47-dbd00f156777-S0
[ OK ] ContentType/MasterAPITest.Subscribe/0 (448 ms)
[ RUN ] ContentType/MasterAPITest.Subscribe/1
I0625 05:38:37.009217 30646 cluster.cpp:162] Creating default 'local' authorizer
I0625 05:38:37.014230 30650 master.cpp:438] Master 7395bba4-e83c-4a4a-9010-d2e89629edeb (7bd48084f726) started on 172.17.0.2:41689
I0625 05:38:37.014291 30650 master.cpp:440] Flags at startup: --acls="" --agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate_agents="true" --authenticate_frameworks="true" --authenticate_http_frameworks="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/D1sbIK/credentials" --filter_gpu_resources="true" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/D1sbIK/master" --zk_session_timeout="10secs"
I0625 05:38:37.014972 30650 master.cpp:490] Master only allowing authenticated frameworks to register
I0625 05:38:37.014992 30650 master.cpp:504] Master only allowing authenticated agents to register
I0625 05:38:37.015008 30650 master.cpp:517] Master only allowing authenticated HTTP frameworks to register
I0625 05:38:37.015019 30650 credentials.hpp:37] Loading credentials for authentication from '/tmp/D1sbIK/credentials'
I0625 05:38:37.015575 30650 master.cpp:562] Using default 'crammd5' authenticator
I0625 05:38:37.016842 30650 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0625 05:38:37.017230 30650 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0625 05:38:37.017542 30650 http.cpp:974] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0625 05:38:37.017822 30650 master.cpp:642] Authorization enabled
I0625 05:38:37.018196 30651 hierarchical.cpp:169] Initialized hierarchical allocator process
I0625 05:38:37.018357 30653 whitelist_watcher.cpp:77] No whitelist given
*** Aborted at 1498369117 (unix time) try "date -d @1498369117" if you are using GNU date ***
PC: @ 0x2b0f5603bc41 std::_Hashtable<>::_M_bucket_begin()
*** SIGSEGV (@0x5d0) received by PID 30646 (TID 0x2b0f641b6700) from PID 1488; stack trace: ***
@ 0x2b0f5bfcc330 (unknown)
@ 0x2b0f5603bc41 std::_Hashtable<>::_M_bucket_begin()
@ 0x2b0f5603bb2d std::_Hashtable<>::count()
@ 0x2b0f5603bacd std::unordered_map<>::count()
@ 0x2b0f56033b68 hashmap<>::contains()
@ 0x2b0f56008d5e mesos::internal::master::Master::exited()
@ 0x2b0f5600aeaa mesos::internal::master::Master::subscribe()::$_36::operator()()
@ 0x2b0f5600ae71 _ZZZNK7process9_DeferredIZN5mesos8internal6master6Master9subscribeERKNS3_14HttpConnectionEE4$_36EcvSt8functionIFvT_EEIRKNS_6FutureI7NothingEEEEvENKUlSJ_E_clESJ_ENKUlvE_clEv
@ 0x2b0f5600abdd _ZNSt17_Function_handlerIFvvEZZNK7process9_DeferredIZN5mesos8internal6master6Master9subscribeERKNS5_14HttpConnectionEE4$_36EcvSt8functionIFvT_EEIRKNS1_6FutureI7NothingEEEEvENKUlSL_E_clESL_EUlvE_E9_M_invokeERKSt9_Any_data
@ 0x1af707e std::function<>::operator()()
@ 0x1eabc09 _ZZN7process8internal8DispatchIvEclIRSt8functionIFvvEEEEvRKNS_4UPIDEOT_ENKUlPNS_11ProcessBaseEE_clESE_
@ 0x1eab9c2 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8internal8DispatchIvEclIRSt8functionIFvvEEEEvRKNS0_4UPIDEOT_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2b0f582e7608 std::function<>::operator()()
@ 0x2b0f582cdab4 process::ProcessBase::visit()
@ 0x2b0f5835da8e process::DispatchEvent::visit()
@ 0x1af66b1 process::ProcessBase::serve()
@ 0x2b0f582cb7a4 process::ProcessManager::resume()
@ 0x2b0f582d982c process::ProcessManager::init_threads()::$_2::operator()()
@ 0x2b0f582d9735 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_2vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
@ 0x2b0f582d9705 std::_Bind_simple<>::operator()()
@ 0x2b0f582d96dc std::thread::_Impl<>::_M_run()
@ 0x2b0f5c28ba60 (unknown)
@ 0x2b0f5bfc4184 start_thread
@ 0x2b0f5caf7ffd (unknown)
make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped)
make[3]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[2]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make: *** [check] Error 2
make[1]: Leaving directory `/mesos/build'
+ docker rmi mesos-1498363601-23977
Untagged: mesos-1498363601-23977:latest
Deleted: sha256:69a9c6d568b2e43fb62381324064d1434184294ecab392dbc88fb2de491bf747
Deleted: sha256:68e95192931eec7d04f2494a2d3733c0eac594251a7bfdf805a9f69e2c3128df
Deleted: sha256:fbcba2775ff6158be9fd24cc366c15409c0e175746cc2f469288c286ae70758b
Deleted: sha256:201198362a1707643de3fbaa3dbcf9eb436c3f677a9de632bbf8d28ff4114633
Deleted: sha256:bf59e70358fa9d05938f1c3853aa7614718f3093d542954a975304ac0ea4b65d
Deleted: sha256:744b507b989374a81b9850d5e46cba97a839190b7e68b96b637d2e9157546266
Deleted: sha256:b8f97c1fdaa332dba9bc8336679d98670184f04d490b31bf2066b836d247b437
Deleted: sha256:298a0ab554c2f67c962100f2d985ccb84d1d3f08c5e67fc079b3164c8cf8f572
Deleted: sha256:00f1ad8a8dccd512e23e631188c73ea43c9dc366ba150bfecb00da67f59aa7c1
Deleted: sha256:826a684aaea66cb886668b58e018cf32b93f3864328018821a208a5d8cd67980
Deleted: sha256:ca12057da3de091cef0eb10634c037c65da0d3fb5068b0a7e431b5651e22dc37
Deleted: sha256:fb1bf8e946d90f02a2decb69440ea933eb668c903805225159d7b23ea1de1a0c
Deleted: sha256:696d0069b5799e26952923e0e409c166ca2ff2c0b8df117d0c7fe5413f8a9558
Deleted: sha256:5002f748b6181055eac5f21143f59bc9213613e8d2dde4e0f059ceef44ade37d
Deleted: sha256:9237f985cc692f10a5cced56070b8e792816171e391395021cce77fb5c6919be
Deleted: sha256:c12927b22aff9de8e8c6510d815aa42509001210f9cca470d76f256b4a3c31fb
Deleted: sha256:48439e177949514e27737efb221e816ebe7f7735ca292c0be0247cc92e8737a7
Deleted: sha256:daeaca50fbe99a8b3c71a2a602cb6a1ee53209af5bf9acda90d9fd09cb276e25
Deleted: sha256:60bdde00e4e66ceaea419290a11b6950e9e11165254449602d536b00b794e384
Deleted: sha256:9726d7006b503cb563112c4a703f28cf0a2bf9689a768e76670a06b7d5b19428
Deleted: sha256:32e100c23beb3173cceb91531b20c183f1eec73a52dc29e20d10bd54c1715dae
Deleted: sha256:c3bdce64a50882990caf44acf8fc6237fe7d8e1be565c9f0f3812fd0ef0442cf
Deleted: sha256:dcdbf3c58373df5f14037f4dcb8e8bc0855410be329d8b73c342038411b26c7b
Deleted: sha256:b8b671ff1747383a42de137aa849ab1ba6c48a62b8b3d9d05779d6dd2c56733e
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com