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 2016/10/01 02:01:55 UTC
Build failed in Jenkins: Mesos » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2722
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2722/changes>
Changes:
[vinodkone] Fixed master to properly handle pending tasks.
[vinodkone] Backported MESOS-6299 for 1.0.2.
------------------------------------------
[...truncated 198598 lines...]
W1001 02:01:31.068840 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.069011 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.073570 28233 slave.cpp:198] Agent started on 554)@172.17.0.3:55226
I1001 02:01:31.073601 28233 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_zBNalb/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_zBNalb/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_zBNalb/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_zBNalb"
I1001 02:01:31.074214 28233 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_zBNalb/credential'
I1001 02:01:31.074374 28233 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.074400 28233 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_zBNalb/http_credentials'
I1001 02:01:31.074698 28233 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.074841 28233 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.075281 28233 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.075654 28233 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.076138 28233 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.076212 28233 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.076227 28233 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.077756 28231 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_AuthorizedRequest_2_zBNalb/meta'
I1001 02:01:31.077805 28233 process.cpp:3364] Handling HTTP event for process 'slave(554)' with path: '/slave(554)/containers'
I1001 02:01:31.078353 28242 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.078536 28238 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.079083 28241 http.cpp:835] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1001 02:01:31.080363 28244 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.080608 28242 slave.cpp:4798] Finished recovery
I1001 02:01:31.081132 28242 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.081321 28229 slave.cpp:4984] Received oversubscribable resources from the resource estimator
I1001 02:01:31.082682 28237 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.AuthorizedRequest/2 (24 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0
I1001 02:01:31.091356 28210 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1001 02:01:31.092123 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.092288 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.095518 28240 slave.cpp:198] Agent started on 555)@172.17.0.3:55226
I1001 02:01:31.095542 28240 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_8DAlNj/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_8DAlNj/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_8DAlNj/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_8DAlNj"
I1001 02:01:31.096174 28240 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_8DAlNj/credential'
I1001 02:01:31.096387 28240 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.096412 28240 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_8DAlNj/http_credentials'
I1001 02:01:31.096686 28240 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.096858 28240 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.097172 28240 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.097573 28240 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.098017 28240 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.098073 28240 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.098093 28240 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.099525 28244 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_0_8DAlNj/meta'
I1001 02:01:31.099592 28240 process.cpp:3364] Handling HTTP event for process 'slave(555)' with path: '/slave(555)/monitor/statistics'
I1001 02:01:31.100314 28241 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.100456 28229 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.100875 28232 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1001 02:01:31.102032 28237 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.102319 28231 slave.cpp:4798] Finished recovery
I1001 02:01:31.102838 28231 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.103210 28239 slave.cpp:4984] Received oversubscribable resources from the resource estimator
I1001 02:01:31.103536 28242 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/0 (21 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1
I1001 02:01:31.112978 28210 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1001 02:01:31.113837 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.114011 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.117486 28236 slave.cpp:198] Agent started on 556)@172.17.0.3:55226
I1001 02:01:31.117571 28236 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_PHzSps/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_PHzSps/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="true" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_PHzSps/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_PHzSps"
I1001 02:01:31.118115 28236 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_PHzSps/credential'
I1001 02:01:31.118412 28236 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.118432 28236 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_PHzSps/http_credentials'
I1001 02:01:31.118698 28236 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.118826 28236 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.119470 28236 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.119807 28236 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.120252 28236 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.120321 28236 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.120343 28236 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.122117 28239 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_1_PHzSps/meta'
I1001 02:01:31.122220 28236 process.cpp:3364] Handling HTTP event for process 'slave(556)' with path: '/slave(556)/monitor/statistics.json'
I1001 02:01:31.122788 28235 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.123128 28232 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.123250 28241 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1001 02:01:31.124429 28234 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.124665 28235 slave.cpp:4798] Finished recovery
I1001 02:01:31.125217 28235 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.125476 28244 slave.cpp:4984] Received oversubscribable resources from the resource estimator
I1001 02:01:31.125869 28231 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/1 (22 ms)
[ RUN ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2
I1001 02:01:31.135478 28210 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1001 02:01:31.136320 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.136487 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.139530 28244 slave.cpp:198] Agent started on 557)@172.17.0.3:55226
I1001 02:01:31.139551 28244 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_DtjldB/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_DtjldB/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_DtjldB/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_DtjldB"
I1001 02:01:31.140125 28244 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_DtjldB/credential'
I1001 02:01:31.140290 28244 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.140316 28244 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_DtjldB/http_credentials'
I1001 02:01:31.140578 28244 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.140794 28244 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.141244 28244 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.141577 28244 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.142021 28244 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.142092 28244 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.142107 28244 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.143358 28240 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_UnauthorizedRequest_2_DtjldB/meta'
I1001 02:01:31.143410 28244 process.cpp:3364] Handling HTTP event for process 'slave(557)' with path: '/slave(557)/containers'
I1001 02:01:31.144554 28233 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.144826 28230 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.144984 28241 http.cpp:835] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1001 02:01:31.146319 28233 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.147047 28233 slave.cpp:4798] Finished recovery
I1001 02:01:31.147591 28233 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.147739 28233 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.UnauthorizedRequest/2 (21 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/0
I1001 02:01:31.157420 28210 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1001 02:01:31.158280 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.158439 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.160197 28210 cluster.cpp:434] Creating default 'local' authorizer
I1001 02:01:31.162142 28238 slave.cpp:198] Agent started on 558)@172.17.0.3:55226
I1001 02:01:31.162160 28238 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RCwubK/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RCwubK/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RCwubK/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_RCwubK"
I1001 02:01:31.162554 28238 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RCwubK/credential'
I1001 02:01:31.162734 28238 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.162755 28238 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RCwubK/http_credentials'
I1001 02:01:31.162945 28238 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.163102 28238 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.163350 28238 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.163584 28238 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.163947 28238 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.164021 28238 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.164036 28238 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.165542 28242 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_0_RCwubK/meta'
I1001 02:01:31.165603 28238 process.cpp:3364] Handling HTTP event for process 'slave(558)' with path: '/slave(558)/monitor/statistics'
I1001 02:01:31.166173 28239 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.166451 28229 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.166604 28239 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics' endpoint
I1001 02:01:31.167405 28239 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.168102 28231 slave.cpp:4798] Finished recovery
I1001 02:01:31.168663 28231 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.168895 28230 slave.cpp:4984] Received oversubscribable resources from the resource estimator
I1001 02:01:31.170016 28241 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/0 (21 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/1
I1001 02:01:31.178748 28210 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1001 02:01:31.179493 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.179654 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.181005 28210 cluster.cpp:434] Creating default 'local' authorizer
I1001 02:01:31.182509 28230 slave.cpp:198] Agent started on 559)@172.17.0.3:55226
I1001 02:01:31.182533 28230 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_xUyekT/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_xUyekT/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_xUyekT/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_xUyekT"
I1001 02:01:31.183112 28230 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_xUyekT/credential'
I1001 02:01:31.183279 28230 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.183305 28230 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_xUyekT/http_credentials'
I1001 02:01:31.183573 28230 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.183850 28230 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.184170 28230 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.184396 28230 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.184718 28230 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.184768 28230 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.184778 28230 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.186395 28238 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_1_xUyekT/meta'
I1001 02:01:31.186399 28230 process.cpp:3364] Handling HTTP event for process 'slave(559)' with path: '/slave(559)/monitor/statistics.json'
I1001 02:01:31.186911 28242 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.187227 28240 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.187355 28243 http.cpp:835] Authorizing principal 'test-principal' to GET the '/monitor/statistics.json' endpoint
I1001 02:01:31.188285 28233 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.188872 28236 slave.cpp:4798] Finished recovery
I1001 02:01:31.189463 28236 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.189695 28234 slave.cpp:4984] Received oversubscribable resources from the resource estimator
I1001 02:01:31.190999 28242 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/1 (21 ms)
[ RUN ] Endpoint/SlaveEndpointTest.NoAuthorizer/2
I1001 02:01:31.200987 28210 containerizer.cpp:196] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni
W1001 02:01:31.201874 28210 backend.cpp:75] Failed to create 'aufs' backend: AufsBackend requires root privileges, but is running as user mesos
W1001 02:01:31.202059 28210 backend.cpp:75] Failed to create 'bind' backend: BindBackend requires root privileges
I1001 02:01:31.203867 28210 cluster.cpp:434] Creating default 'local' authorizer
I1001 02:01:31.205688 28234 slave.cpp:198] Agent started on 560)@172.17.0.3:55226
I1001 02:01:31.205709 28234 slave.cpp:199] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_JFGjD2/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_JFGjD2/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_JFGjD2/http_credentials" --image_provisioner_backend="copy" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher_dir="/mesos/mesos-1.0.1/_build/src" --logbufsecs="0" --logging_level="INFO" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --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_JFGjD2"
I1001 02:01:31.206248 28234 credentials.hpp:86] Loading credential for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_JFGjD2/credential'
I1001 02:01:31.206406 28234 slave.cpp:336] Agent using credential for: test-principal
I1001 02:01:31.206434 28234 credentials.hpp:37] Loading credentials for authentication from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_JFGjD2/http_credentials'
I1001 02:01:31.206693 28234 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1001 02:01:31.206850 28234 http.cpp:883] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I1001 02:01:31.207294 28234 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.207609 28234 resources.cpp:572] Parsing resources as JSON failed: cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]
Trying semicolon-delimited string format instead
I1001 02:01:31.208220 28234 slave.cpp:519] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I1001 02:01:31.208281 28234 slave.cpp:527] Agent attributes: [ ]
I1001 02:01:31.208299 28234 slave.cpp:532] Agent hostname: edc16181a80b
I1001 02:01:31.209796 28239 state.cpp:57] Recovering state from '/tmp/Endpoint_SlaveEndpointTest_NoAuthorizer_2_JFGjD2/meta'
I1001 02:01:31.209882 28234 process.cpp:3364] Handling HTTP event for process 'slave(560)' with path: '/slave(560)/containers'
I1001 02:01:31.210286 28232 status_update_manager.cpp:200] Recovering status update manager
I1001 02:01:31.210537 28229 containerizer.cpp:522] Recovering containerizer
I1001 02:01:31.210889 28240 http.cpp:835] Authorizing principal 'test-principal' to GET the '/containers' endpoint
I1001 02:01:31.211866 28239 provisioner.cpp:253] Provisioner recovery complete
I1001 02:01:31.212291 28230 slave.cpp:4798] Finished recovery
I1001 02:01:31.212795 28230 slave.cpp:4970] Querying resource estimator for oversubscribable resources
I1001 02:01:31.213021 28231 slave.cpp:4984] Received oversubscribable resources from the resource estimator
I1001 02:01:31.214633 28238 slave.cpp:767] Agent terminating
[ OK ] Endpoint/SlaveEndpointTest.NoAuthorizer/2 (24 ms)
[----------] 9 tests from Endpoint/SlaveEndpointTest (204 ms total)
[----------] Global test environment tear-down
[==========] 1242 tests from 140 test cases ran. (528695 ms total)
[ PASSED ] 1240 tests.
[ FAILED ] 2 tests, listed below:
[ FAILED ] ReservationTest.SendingCheckpointResourcesMessage
[ FAILED ] Strict/RegistrarTest.UpdateMaintenanceSchedule/0, where GetParam() = false
2 FAILED TESTS
YOU HAVE 6 DISABLED TESTS
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.0.1/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.0.1/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.0.1/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.0.1/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1475285047-19976
Untagged: mesos-1475285047-19976:latest
Deleted: sha256:cbe12cea19809366b4a46f04cc01f75254eaacffbf4e5d1d09fc5c028ef39673
Deleted: sha256:98392ae8562483b56587067bed21df749987f43e4dc18f73eef9cae0b1bf24c5
Deleted: sha256:c934d562f87e8e1d98d3209b1598fd3d03c863fe61f898ed978523f561bdd4ac
Deleted: sha256:0d544b17b10c790981a8068219a7f7874e20d2407a3a0feef98a4b6f17fa7874
Deleted: sha256:8c04561953724a9a9483fe880cd60cc33a22de345086622ec47351eb01145d9a
Deleted: sha256:4329235e2bb13b8c24644be67a639f821a8736d18b5df1fd4f1dfd699dfd1aef
Deleted: sha256:2301834296de3789024a28f5136718dc796d2ad4e59eeba425971c606ef8b6ec
Deleted: sha256:70fdafa8be799e9f5e9c727692d704472e98ce3a2a6fe00ee3d99c56ec9e5a7f
Deleted: sha256:c22aaad34b4779c433f4daabc2c1132e1ceb0fad78bb340308f73d0e44e78dc8
Deleted: sha256:786b4a6e88441c0a351086e91fb239437642767f17044011f805f21b05f3efed
Deleted: sha256:aea5cfa5d4ae24a9c11119fc8ae28ebe3783c001261a7d293e1094b584155374
Deleted: sha256:d0fd63cb8c5eb807677d4be55042ea7ad81b66ffdd6d4a4e424c93d5634c2622
Deleted: sha256:0fa40b0284ecb08ec3a4a64ce8fc61288257a8cf808695e2ce541957e023fd84
Deleted: sha256:ea7bb62a8be70de61314da7a5d105d289630d9221554973b41777f5e8e40a274
Deleted: sha256:d7d19f10f1609a9d1caa1e5e6e8241f76932122d68ae171187a2080d6ddde5cd
Deleted: sha256:f1d4ef04c385d85d92e6ea3d03f56b3965f44c97f2de957faaf01e928a79a3ae
Deleted: sha256:62afef1828cf04986501c9f5f8262833d36d52d951440741d170d09c6e796f53
Deleted: sha256:27842e868a00880daaf0b8b4c1241e9acf29e563f4218f9b4b769fe3cea783e0
Deleted: sha256:c9ebed714e438e4f98dafcfa6263e57c9cdadedbdbda0a4fc91f4ec4643a4eef
Deleted: sha256:853222b181cebc6e7f6f0ef431d39bfa052288d7614e9ff3edaedfa9f665ccf2
Deleted: sha256:e25de34db07faa28a48f57875443debd84ad44c742f9311acd6cf71c40f19be8
Deleted: sha256:dcdb89df34dcfab184c37bb159a5384b6ad03368a392db01a29e360305779910
Build step 'Execute shell' marked build as failure
Jenkins build is back to normal : Mesos » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2725
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2725/>
Build failed in Jenkins: Mesos » autotools,gcc,--verbose,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-6) #2724
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-6)/2724/changes>
Changes:
[vinodkone] Fixed master to properly handle pending tasks.
[vinodkone] Backported MESOS-6299 for 0.28.3.
------------------------------------------
[...truncated 109708 lines...]
I1004 03:53:23.898857 761 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 487076ns
I1004 03:53:23.898890 761 replica.cpp:712] Persisted action at 4
I1004 03:53:23.898982 768 hierarchical.cpp:1577] No inverse offers to send out!
I1004 03:53:23.898999 762 slave.cpp:1050] Forwarding total oversubscribed resources
I1004 03:53:23.899032 768 hierarchical.cpp:1179] Performed allocation for slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 in 927200ns
I1004 03:53:23.899207 768 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.899250 768 hierarchical.cpp:1577] No inverse offers to send out!
I1004 03:53:23.899271 761 master.cpp:5327] Sending 1 offers to framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000 (default) at scheduler-f0d02bb5-0bba-44ac-9cf6-1304cb49f042@172.17.0.2:46286
I1004 03:53:23.899278 768 hierarchical.cpp:1159] Performed allocation for 1 slaves in 183912ns
I1004 03:53:23.899520 761 master.cpp:4621] Received update of slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 at slave(273)@172.17.0.2:46286 (3b8f86d1902b) with total oversubscribed resources
I1004 03:53:23.899863 765 sched.cpp:893] Scheduler::resourceOffers took 219825ns
I1004 03:53:23.899895 772 replica.cpp:691] Replica received learned notice for position 4 from @0.0.0.0:0
I1004 03:53:23.899904 764 hierarchical.cpp:537] Slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 (3b8f86d1902b) updated with oversubscribed resources (total: cpus(*):8; mem(*):2048; disk(*):3.70122e+06; ports(*):[31000-32000], allocated: cpus(*):8; mem(*):2048; disk(*):3.70122e+06; ports(*):[31000-32000])
I1004 03:53:23.900209 764 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.900276 764 hierarchical.cpp:1577] No inverse offers to send out!
I1004 03:53:23.900327 764 hierarchical.cpp:1179] Performed allocation for slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 in 360823ns
I1004 03:53:23.900348 772 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 420621ns
I1004 03:53:23.900418 772 leveldb.cpp:399] Deleting ~2 keys from leveldb took 42338ns
I1004 03:53:23.900439 772 replica.cpp:712] Persisted action at 4
I1004 03:53:23.900463 772 replica.cpp:697] Replica learned TRUNCATE action at position 4
I1004 03:53:23.901415 757 master.cpp:3104] Processing ACCEPT call for offers: [ 05046be5-904f-4bab-ab50-b7621c60cb7e-O0 ] on slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 at slave(273)@172.17.0.2:46286 (3b8f86d1902b) for framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000 (default) at scheduler-f0d02bb5-0bba-44ac-9cf6-1304cb49f042@172.17.0.2:46286
I1004 03:53:23.901479 757 master.cpp:2820] Authorizing principal 'test-principal' to reserve resources 'cpus(role, test-principal):8; mem(role, test-principal):2048'
I1004 03:53:23.902515 758 master.cpp:3334] Applying RESERVE operation for resources cpus(role, test-principal):8; mem(role, test-principal):2048 from framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000 (default) at scheduler-f0d02bb5-0bba-44ac-9cf6-1304cb49f042@172.17.0.2:46286 to slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 at slave(273)@172.17.0.2:46286 (3b8f86d1902b)
I1004 03:53:23.903170 758 master.cpp:6563] Sending checkpointed resources cpus(role, test-principal):8; mem(role, test-principal):2048 to slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 at slave(273)@172.17.0.2:46286 (3b8f86d1902b)
I1004 03:53:23.904137 763 slave.cpp:2354] Updated checkpointed resources from to cpus(role, test-principal):8; mem(role, test-principal):2048
I1004 03:53:23.905015 759 hierarchical.cpp:678] Updated allocation of framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000 on slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 from cpus(*):8; mem(*):2048; disk(*):3.70122e+06; ports(*):[31000-32000] to ports(*):[31000-32000]; cpus(role, test-principal):8; disk(*):3.70122e+06; mem(role, test-principal):2048
I1004 03:53:23.905791 759 hierarchical.cpp:919] Recovered ports(*):[31000-32000]; cpus(role, test-principal):8; disk(*):3.70122e+06; mem(role, test-principal):2048 (total: ports(*):[31000-32000]; cpus(role, test-principal):8; disk(*):3.70122e+06; mem(role, test-principal):2048, allocated: ) on slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 from framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000
I1004 03:53:23.914325 738 master.cpp:1026] Master terminating
I1004 03:53:23.914705 762 hierarchical.cpp:505] Removed slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0
I1004 03:53:23.915210 764 hierarchical.cpp:326] Removed framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000
I1004 03:53:23.915541 761 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.915581 761 hierarchical.cpp:1159] Performed allocation for 0 slaves in 107914ns
I1004 03:53:23.915810 771 slave.cpp:3565] master@172.17.0.2:46286 exited
W1004 03:53:23.915844 771 slave.cpp:3568] Master disconnected! Waiting for a new master to be elected
I1004 03:53:23.924022 738 leveldb.cpp:174] Opened db in 3.140313ms
I1004 03:53:23.926293 738 leveldb.cpp:181] Compacted db in 2.233349ms
I1004 03:53:23.926354 738 leveldb.cpp:196] Created db iterator in 24284ns
I1004 03:53:23.926398 738 leveldb.cpp:202] Seeked to beginning of db in 23567ns
I1004 03:53:23.926491 738 leveldb.cpp:271] Iterated through 3 keys in the db in 73897ns
I1004 03:53:23.926551 738 replica.cpp:779] Replica recovered with log positions 3 -> 4 with 0 holes and 0 unlearned
I1004 03:53:23.927031 770 recover.cpp:447] Starting replica recovery
I1004 03:53:23.927578 763 recover.cpp:473] Replica is in VOTING status
I1004 03:53:23.927858 763 recover.cpp:462] Recover process terminated
I1004 03:53:23.929714 759 master.cpp:375] Master 39d4b871-f18f-40e6-aea7-0f02fcb71ada (3b8f86d1902b) started on 172.17.0.2:46286
I1004 03:53:23.929738 759 master.cpp:377] Flags at startup: --acls="" --allocation_interval="5ms" --allocator="HierarchicalDRF" --authenticate="true" --authenticate_http="true" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/FuTpeF/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%" --registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="100secs" --registry_strict="true" --roles="role" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-0.28.3/_inst/share/mesos/webui" --work_dir="/tmp/FuTpeF/master" --zk_session_timeout="10secs"
I1004 03:53:23.930130 759 master.cpp:422] Master only allowing authenticated frameworks to register
I1004 03:53:23.930145 759 master.cpp:427] Master only allowing authenticated slaves to register
I1004 03:53:23.930155 759 credentials.hpp:35] Loading credentials for authentication from '/tmp/FuTpeF/credentials'
I1004 03:53:23.930490 759 master.cpp:467] Using default 'crammd5' authenticator
I1004 03:53:23.930632 759 master.cpp:536] Using default 'basic' HTTP authenticator
I1004 03:53:23.930766 759 master.cpp:570] Authorization enabled
W1004 03:53:23.930785 759 master.cpp:630] The '--roles' flag is deprecated. This flag will be removed in the future. See the Mesos 0.27 upgrade notes for more information
I1004 03:53:23.931059 767 hierarchical.cpp:145] Initialized hierarchical allocator process
I1004 03:53:23.931130 768 whitelist_watcher.cpp:77] No whitelist given
I1004 03:53:23.933502 770 master.cpp:1711] The newly elected leader is master@172.17.0.2:46286 with id 39d4b871-f18f-40e6-aea7-0f02fcb71ada
I1004 03:53:23.933542 770 master.cpp:1724] Elected as the leading master!
I1004 03:53:23.933568 770 master.cpp:1469] Recovering from registrar
I1004 03:53:23.933872 772 registrar.cpp:307] Recovering registrar
I1004 03:53:23.934463 758 log.cpp:659] Attempting to start the writer
I1004 03:53:23.936133 761 replica.cpp:493] Replica received implicit promise request from (8880)@172.17.0.2:46286 with proposal 2
I1004 03:53:23.936566 758 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.936633 758 hierarchical.cpp:1159] Performed allocation for 0 slaves in 111347ns
I1004 03:53:23.936745 761 leveldb.cpp:304] Persisting metadata (8 bytes) to leveldb took 570985ns
I1004 03:53:23.936784 761 replica.cpp:342] Persisted promised to 2
I1004 03:53:23.937610 763 coordinator.cpp:238] Coordinator attempting to fill missing positions
I1004 03:53:23.937925 771 log.cpp:675] Writer started with ending position 4
I1004 03:53:23.939249 767 leveldb.cpp:436] Reading position from leveldb took 55060ns
I1004 03:53:23.939352 767 leveldb.cpp:436] Reading position from leveldb took 40196ns
I1004 03:53:23.941316 766 registrar.cpp:340] Successfully fetched the registry (300B) in 7.329792ms
I1004 03:53:23.941516 766 registrar.cpp:439] Applied 1 operations in 53150ns; attempting to update the 'registry'
I1004 03:53:23.942214 768 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.942245 768 hierarchical.cpp:1159] Performed allocation for 0 slaves in 72902ns
I1004 03:53:23.942538 761 log.cpp:683] Attempting to append 339 bytes to the log
I1004 03:53:23.942908 770 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 5
I1004 03:53:23.944162 758 replica.cpp:537] Replica received write request for position 5 from (8881)@172.17.0.2:46286
I1004 03:53:23.944701 758 leveldb.cpp:341] Persisting action (358 bytes) to leveldb took 492235ns
I1004 03:53:23.944732 758 replica.cpp:712] Persisted action at 5
I1004 03:53:23.945471 763 replica.cpp:691] Replica received learned notice for position 5 from @0.0.0.0:0
I1004 03:53:23.945714 763 leveldb.cpp:341] Persisting action (360 bytes) to leveldb took 207333ns
I1004 03:53:23.945744 763 replica.cpp:712] Persisted action at 5
I1004 03:53:23.945766 763 replica.cpp:697] Replica learned APPEND action at position 5
I1004 03:53:23.947222 763 registrar.cpp:484] Successfully updated the 'registry' in 5.642752ms
I1004 03:53:23.947453 763 registrar.cpp:370] Successfully recovered registrar
I1004 03:53:23.947533 765 log.cpp:702] Attempting to truncate the log to 5
I1004 03:53:23.947664 769 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 6
I1004 03:53:23.947753 758 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.947861 758 hierarchical.cpp:1159] Performed allocation for 0 slaves in 152168ns
I1004 03:53:23.948626 760 master.cpp:1521] Recovered 1 slaves from the Registry (300B) ; allowing 10mins for slaves to re-register
I1004 03:53:23.948643 766 hierarchical.cpp:172] Skipping recovery of hierarchical allocator: nothing to recover
I1004 03:53:23.949059 768 replica.cpp:537] Replica received write request for position 6 from (8882)@172.17.0.2:46286
I1004 03:53:23.949445 768 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 344661ns
I1004 03:53:23.949472 768 replica.cpp:712] Persisted action at 6
I1004 03:53:23.950515 762 replica.cpp:691] Replica received learned notice for position 6 from @0.0.0.0:0
I1004 03:53:23.950695 762 leveldb.cpp:341] Persisting action (18 bytes) to leveldb took 146950ns
I1004 03:53:23.950760 762 leveldb.cpp:399] Deleting ~2 keys from leveldb took 37704ns
I1004 03:53:23.950781 762 replica.cpp:712] Persisted action at 6
I1004 03:53:23.950805 762 replica.cpp:697] Replica learned TRUNCATE action at position 6
I1004 03:53:23.959655 766 slave.cpp:798] New master detected at master@172.17.0.2:46286
I1004 03:53:23.959661 771 status_update_manager.cpp:174] Pausing sending status updates
I1004 03:53:23.959713 766 slave.cpp:857] Authenticating with master master@172.17.0.2:46286
I1004 03:53:23.959849 759 sched.cpp:322] Scheduler::disconnected took 76535ns
I1004 03:53:23.959879 759 sched.cpp:328] New master detected at master@172.17.0.2:46286
I1004 03:53:23.959883 766 slave.cpp:866] Using default CRAM-MD5 authenticatee
I1004 03:53:23.959992 759 sched.cpp:384] Authenticating with master master@172.17.0.2:46286
I1004 03:53:23.960019 759 sched.cpp:391] Using default CRAM-MD5 authenticatee
I1004 03:53:23.960094 766 slave.cpp:830] Detecting new master
I1004 03:53:23.960218 769 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.960253 769 hierarchical.cpp:1159] Performed allocation for 0 slaves in 224824ns
I1004 03:53:23.960304 757 authenticatee.cpp:121] Creating new client SASL connection
I1004 03:53:23.960374 763 authenticatee.cpp:121] Creating new client SASL connection
I1004 03:53:23.960714 772 master.cpp:5498] Authenticating slave(273)@172.17.0.2:46286
I1004 03:53:23.960832 762 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(598)@172.17.0.2:46286
I1004 03:53:23.960966 772 master.cpp:5498] Authenticating scheduler-f0d02bb5-0bba-44ac-9cf6-1304cb49f042@172.17.0.2:46286
I1004 03:53:23.961081 759 authenticator.cpp:98] Creating new server SASL connection
I1004 03:53:23.961103 762 authenticator.cpp:413] Starting authentication session for crammd5_authenticatee(599)@172.17.0.2:46286
I1004 03:53:23.961328 764 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I1004 03:53:23.961349 758 authenticator.cpp:98] Creating new server SASL connection
I1004 03:53:23.961359 764 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I1004 03:53:23.961545 764 authenticator.cpp:203] Received SASL authentication start
I1004 03:53:23.961587 769 authenticatee.cpp:212] Received SASL authentication mechanisms: CRAM-MD5
I1004 03:53:23.961618 764 authenticator.cpp:325] Authentication requires more steps
I1004 03:53:23.961621 769 authenticatee.cpp:238] Attempting to authenticate with mechanism 'CRAM-MD5'
I1004 03:53:23.961751 763 authenticatee.cpp:258] Received SASL authentication step
I1004 03:53:23.961778 764 authenticator.cpp:203] Received SASL authentication start
I1004 03:53:23.961835 764 authenticator.cpp:325] Authentication requires more steps
I1004 03:53:23.961902 766 authenticator.cpp:231] Received SASL authentication step
I1004 03:53:23.961940 766 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: '3b8f86d1902b' server FQDN: '3b8f86d1902b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1004 03:53:23.961959 766 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I1004 03:53:23.962013 760 authenticatee.cpp:258] Received SASL authentication step
I1004 03:53:23.962013 766 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1004 03:53:23.962085 766 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: '3b8f86d1902b' server FQDN: '3b8f86d1902b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1004 03:53:23.962102 766 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1004 03:53:23.962117 766 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1004 03:53:23.962146 766 authenticator.cpp:317] Authentication success
I1004 03:53:23.962149 769 authenticator.cpp:231] Received SASL authentication step
I1004 03:53:23.962184 769 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: '3b8f86d1902b' server FQDN: '3b8f86d1902b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I1004 03:53:23.962198 769 auxprop.cpp:179] Looking up auxiliary property '*userPassword'
I1004 03:53:23.962234 769 auxprop.cpp:179] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1004 03:53:23.962254 760 authenticatee.cpp:298] Authentication success
I1004 03:53:23.962277 769 auxprop.cpp:107] Request to lookup properties for user: 'test-principal' realm: '3b8f86d1902b' server FQDN: '3b8f86d1902b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I1004 03:53:23.962301 769 auxprop.cpp:129] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1004 03:53:23.962312 769 auxprop.cpp:129] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1004 03:53:23.962333 769 authenticator.cpp:317] Authentication success
I1004 03:53:23.962344 765 master.cpp:5528] Successfully authenticated principal 'test-principal' at slave(273)@172.17.0.2:46286
I1004 03:53:23.962435 762 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(598)@172.17.0.2:46286
I1004 03:53:23.962461 761 authenticatee.cpp:298] Authentication success
I1004 03:53:23.962558 764 master.cpp:5528] Successfully authenticated principal 'test-principal' at scheduler-f0d02bb5-0bba-44ac-9cf6-1304cb49f042@172.17.0.2:46286
I1004 03:53:23.962766 762 authenticator.cpp:431] Authentication session cleanup for crammd5_authenticatee(599)@172.17.0.2:46286
I1004 03:53:23.962810 759 slave.cpp:945] Successfully authenticated with master master@172.17.0.2:46286
I1004 03:53:23.963001 769 sched.cpp:489] Successfully authenticated with master master@172.17.0.2:46286
I1004 03:53:23.963029 769 sched.cpp:796] Sending SUBSCRIBE call to master@172.17.0.2:46286
I1004 03:53:23.963094 759 slave.cpp:1348] Will retry registration in 13.443492ms if necessary
I1004 03:53:23.963145 769 sched.cpp:829] Will retry registration in 854.454671ms if necessary
I1004 03:53:23.963302 757 master.cpp:4442] Re-registering slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 at slave(273)@172.17.0.2:46286 (3b8f86d1902b)
I1004 03:53:23.963796 757 master.cpp:2231] Received SUBSCRIBE call for framework 'default' at scheduler-f0d02bb5-0bba-44ac-9cf6-1304cb49f042@172.17.0.2:46286
I1004 03:53:23.963853 758 registrar.cpp:439] Applied 1 operations in 65605ns; attempting to update the 'registry'
I1004 03:53:23.963863 757 master.cpp:1750] Authorizing framework principal 'test-principal' to receive offers for role 'role'
I1004 03:53:23.964246 761 master.cpp:2302] Subscribing framework default with checkpointing disabled and capabilities [ ]
I1004 03:53:23.964702 767 hierarchical.cpp:266] Added framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000
I1004 03:53:23.964764 767 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:23.964794 767 hierarchical.cpp:1577] No inverse offers to send out!
I1004 03:53:23.964841 757 sched.cpp:723] Framework registered with 05046be5-904f-4bab-ab50-b7621c60cb7e-0000
I1004 03:53:23.964859 763 log.cpp:683] Attempting to append 339 bytes to the log
I1004 03:53:23.964823 767 hierarchical.cpp:1159] Performed allocation for 0 slaves in 94696ns
I1004 03:53:23.964898 757 sched.cpp:737] Scheduler::registered took 26894ns
I1004 03:53:23.964980 762 coordinator.cpp:348] Coordinator attempting to write APPEND action at position 7
I1004 03:53:23.977398 758 slave.cpp:1348] Will retry registration in 11.059381ms if necessary
I1004 03:53:23.977602 772 master.cpp:4435] Ignoring re-register slave message from slave 05046be5-904f-4bab-ab50-b7621c60cb7e-S0 at slave(273)@172.17.0.2:46286 (3b8f86d1902b) as readmission is already in progress
I1004 03:53:50.761623 767 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:50.761721 767 hierarchical.cpp:1577] No inverse offers to send out!
I1004 03:53:50.761772 767 hierarchical.cpp:1159] Performed allocation for 0 slaves in 322246ns
I1004 03:53:50.762043 758 slave.cpp:4749] Querying resource estimator for oversubscribable resources
I1004 03:53:50.763003 769 slave.cpp:4763] Received oversubscribable resources from the resource estimator
I1004 03:53:50.764325 767 replica.cpp:537] Replica received write request for position 7 from (8883)@172.17.0.2:46286
I1004 03:53:50.764430 758 slave.cpp:787] Re-detecting master
I1004 03:53:50.764459 758 slave.cpp:830] Detecting new master
F1004 03:53:50.764459 758 logging.cpp:64] RAW: Pure virtual method called
I1004 03:53:50.764559 760 status_update_manager.cpp:174] Pausing sending status updates
I1004 03:53:50.764686 767 leveldb.cpp:341] Persisting action (358 bytes) to leveldb took 288802ns
I1004 03:53:50.764729 767 replica.cpp:712] Persisted action at 7
I1004 03:53:50.765750 761 replica.cpp:691] Replica received learned notice for position 7 from @0.0.0.0:0
I1004 03:53:50.766248 761 leveldb.cpp:341] Persisting action (360 bytes) to leveldb took 457734ns
I1004 03:53:50.766288 761 replica.cpp:712] Persisted action at 7
I1004 03:53:50.766288 772 master.cpp:1026] Master terminating
I1004 03:53:50.766336 761 replica.cpp:697] Replica learned APPEND action at position 7
I1004 03:53:50.766614 760 hierarchical.cpp:326] Removed framework 05046be5-904f-4bab-ab50-b7621c60cb7e-0000
I1004 03:53:50.767493 764 hierarchical.cpp:1482] No resources available to allocate!
I1004 03:53:50.767544 764 hierarchical.cpp:1159] Performed allocation for 0 slaves in 197063ns
I1004 03:53:50.768754 766 registrar.cpp:484] Successfully updated the 'registry' in 26.804774912secs
I1004 03:53:50.769006 762 log.cpp:702] Attempting to truncate the log to 7
I1004 03:53:50.769265 763 coordinator.cpp:348] Coordinator attempting to write TRUNCATE action at position 8
I1004 03:53:50.770607 764 replica.cpp:537] Replica received write request for position 8 from (8884)@172.17.0.2:46286
I1004 03:53:50.771081 764 leveldb.cpp:341] Persisting action (16 bytes) to leveldb took 414251ns
I1004 03:53:50.771123 764 replica.cpp:712] Persisted action at 8
@ 0x2b548d2ac6aa google::LogMessage::Fail()
@ 0x2b548d2b1d5a google::RawLog__()
@ 0x2b548c3f1a6e __cxa_pure_virtual
@ 0x2b548c78fa1e mesos::internal::slave::Slave::detected()
@ 0x2b548c7e7a91 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureI6OptionINS1_10MasterInfoEEEES9_EEvRKNS_3PIDIT_EEMSD_FvT0_ET1_ENKUlPNS_11ProcessBaseEE_clESM_
@ 0x2b548c81e77a _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureI6OptionINS5_10MasterInfoEEEESD_EEvRKNS0_3PIDIT_EEMSH_FvT0_ET1_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x2b548d22bbcb std::function<>::operator()()
@ 0x2b548d2119f3 process::ProcessBase::visit()
@ 0x2b548d217a9e process::DispatchEvent::visit()
@ 0x9b03ec process::ProcessBase::serve()
@ 0x2b548d20dbc8 process::ProcessManager::resume()
@ 0x2b548d20ac80 _ZZN7process14ProcessManager12init_threadsEvENKUlRKSt11atomic_boolE_clES3_
@ 0x2b548d21728a _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEE6__callIvIEILm0EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
@ 0x2b548d21723a _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEEclIIEvEET0_DpOT_
@ 0x2b548d2171cc _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
@ 0x2b548d217123 _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEEclEv
@ 0x2b548d2170bc _ZNSt6thread5_ImplISt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS6_EEEvEEE6_M_runEv
@ 0x2b548e856a60 (unknown)
@ 0x2b548efcd184 start_thread
@ 0x2b548f2dd37d (unknown)
make[4]: *** [check-local] Aborted
make[4]: Leaving directory `/mesos/mesos-0.28.3/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-0.28.3/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-0.28.3/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-0.28.3/_build'
make: *** [distcheck] Error 1
+ docker rmi mesos-1475551140-4615
Untagged: mesos-1475551140-4615:latest
Deleted: sha256:724d1a2967d1747d2cae782ab595fed286b67a84a24acd83f8a52189c5c31bbd
Deleted: sha256:57b47e5f1553562c78a0badd40632c62eb0d3201e096c4b306227bcaf57b0bcf
Deleted: sha256:2d23e1cda02303e9f15e2867afe0511a97b741ddc6ff772aa01b424b5887f492
Deleted: sha256:404e2ecb739a3d15d49062ca20b81253aa3cde95f75b414ed080bdfeb0989924
Deleted: sha256:42d0dab312ba425e2367abf41a4ff5573207f94394e08505ab513b4f28ec894e
Deleted: sha256:5619dd5b1e733f4aa0bc481ca6fb6094e77cdc2d39fa8020d72be66293198550
Deleted: sha256:b27b242851b3a7123accc4725f472390c76b0b509b320a9e94d149e47c72d950
Deleted: sha256:5be074c11a66c2d73983f87b6693b7babf08018bea915585a6c6d2306591720e
Deleted: sha256:9f36a4485f0d608af0e69f0c59e753aab534b4802ac294d45b0e49f01e2e042e
Deleted: sha256:fcbfcbac70fbb7097c74884b5ff93030979ea11f9bf3ff6ff55e11a69e0e6c8a
Deleted: sha256:fd6f5137ae5b7232a4c5e65cb1596f83835af54c66a0dbbf34920e9c11dc2272
Deleted: sha256:506472e50d16b4ac26e2fa122c40da20fd03ae9c9f4209a20a0e3e22b8466cc6
Deleted: sha256:cbedf06e9d6c4883d2f66f81bc1d3d34fb4ab93fdcfc52bfeae31014b06833cd
Deleted: sha256:e52e47cc2200d568cdd25eaaacfb0657c4f6f85c479623bc70b7dcb69bbdfe09
Deleted: sha256:9ff4ab81db34042d532a56adeaed1c4e77bf4fd1748036749e9977bb17c16474
Deleted: sha256:bbd1ce30746911e9aebb16dae30fac90a7dd467a0656c59b8e2b33d8e8cfc33f
Deleted: sha256:97e1855ae24d2d06d366aac09d895a4f2f314854b9bf7f1f9ab02662d5546445
Deleted: sha256:9090cfee23798f01c19e0b6a53d6dcaa56f31ae71dbdd40ddb82708204490031
Deleted: sha256:2b1755735a4219c085eae7329f3aab90cc26902ae89b2dc5571aaf9dd24168f4
Deleted: sha256:c4021c2216e5fc6e05a62e304ef648e20b7768c7be87be789d52e32a5f43da86
Deleted: sha256:738df05da1e1da0b8e654a6c6c425aa069349205d799b4461ca82709022f6810
Deleted: sha256:a1a45e1a0868137c0274e7f5b7a9fda2e2485db9b88e32c2ecfa99c9b1b598e3
Deleted: sha256:6a80e419c7e0a82fab85a9c30dad2a82035c96f8f497d3f262c7ee38fd813785
Build step 'Execute shell' marked build as failure