See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3582/display/redirect?page=changes>
Changes: [haosdent] Included `glyphicons-halflings-regular.woff2` when `make dist`. ------------------------------------------ [...truncated 15.28 MB...] I0429 17:35:28.107728 1454 authenticatee.cpp:259] Received SASL authentication step I0429 17:35:28.107904 1458 authenticator.cpp:232] Received SASL authentication step I0429 17:35:28.107942 1458 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7612e6593663' server FQDN: '7612e6593663' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0429 17:35:28.107961 1458 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0429 17:35:28.108000 1458 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0429 17:35:28.108036 1458 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7612e6593663' server FQDN: '7612e6593663' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0429 17:35:28.108055 1458 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0429 17:35:28.108121 1458 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0429 17:35:28.108147 1458 authenticator.cpp:318] Authentication success I0429 17:35:28.108327 1458 authenticatee.cpp:299] Authentication success I0429 17:35:28.108430 1458 master.cpp:7469] Successfully authenticated principal 'test-principal' at slave(325)@172.17.0.2:52206 I0429 17:35:28.108523 1458 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(712)@172.17.0.2:52206 I0429 17:35:28.108825 1458 slave.cpp:1075] Successfully authenticated with master [email protected]:52206 I0429 17:35:28.108979 1458 slave.cpp:1503] Will retry registration in 12.728771ms if necessary I0429 17:35:28.109261 1458 master.cpp:5429] Received register agent message from slave(325)@172.17.0.2:52206 (7612e6593663) I0429 17:35:28.109400 1458 master.cpp:3659] Authorizing agent with principal 'test-principal' I0429 17:35:28.109910 1463 master.cpp:5546] Registering agent at slave(325)@172.17.0.2:52206 (7612e6593663) with id fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 I0429 17:35:28.110405 1462 registrar.cpp:493] Applied 1 operations in 65650ns; attempting to update the registry I0429 17:35:28.111373 1462 registrar.cpp:550] Successfully updated the registry in 902912ns I0429 17:35:28.112083 1462 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.112155 1457 master.cpp:5621] Registered agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 at slave(325)@172.17.0.2:52206 (7612e6593663) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0429 17:35:28.112393 1462 slave.cpp:1121] Registered with master [email protected]:52206; given agent ID fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 I0429 17:35:28.112428 1462 fetcher.cpp:94] Clearing fetcher cache I0429 17:35:28.112593 1458 status_update_manager.cpp:184] Resuming sending status updates I0429 17:35:28.112617 1460 hierarchical.cpp:525] Added agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 (7612e6593663) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0429 17:35:28.112840 1462 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/PartitionTest_FailHealthChecksTwice_KcV0Uk/meta/slaves/fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0/slave.info' I0429 17:35:28.113224 1462 slave.cpp:1187] Forwarding total oversubscribed resources {} I0429 17:35:28.113514 1456 master.cpp:6288] Received update of agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 at slave(325)@172.17.0.2:52206 (7612e6593663) with total oversubscribed resources {} I0429 17:35:28.114097 1460 hierarchical.cpp:1940] No inverse offers to send out! I0429 17:35:28.114147 1460 hierarchical.cpp:1434] Performed allocation for 1 agents in 1.181007ms I0429 17:35:28.114732 1451 master.cpp:7269] Sending 1 offers to framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 (default) at [email protected]:52206 I0429 17:35:28.115208 1464 sched.cpp:933] Scheduler::resourceOffers took 64254ns I0429 17:35:28.116674 1459 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.116683 1458 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.116752 1459 hierarchical.cpp:1940] No inverse offers to send out! I0429 17:35:28.116859 1459 hierarchical.cpp:1434] Performed allocation for 1 agents in 340796ns I0429 17:35:28.116899 1458 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.117172 1458 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.117790 1459 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.118018 1464 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.118019 1459 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.118118 1464 hierarchical.cpp:1940] No inverse offers to send out! I0429 17:35:28.118230 1464 hierarchical.cpp:1434] Performed allocation for 1 agents in 350076ns I0429 17:35:28.118314 1459 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.118871 1464 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.118937 1462 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.119112 1462 hierarchical.cpp:1940] No inverse offers to send out! I0429 17:35:28.119130 1464 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.119182 1462 hierarchical.cpp:1434] Performed allocation for 1 agents in 354358ns I0429 17:35:28.119333 1464 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.119990 1454 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.120010 1450 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.120044 1454 hierarchical.cpp:1940] No inverse offers to send out! I0429 17:35:28.120118 1454 hierarchical.cpp:1434] Performed allocation for 1 agents in 221972ns I0429 17:35:28.120138 1450 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.120317 1450 slave.cpp:5659] Current disk usage 9.87%. Max allowed age: 5.609071824683183days I0429 17:35:28.120467 1450 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.120992 1452 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.121112 1455 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.121145 1452 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.121175 1455 hierarchical.cpp:1940] No inverse offers to send out! I0429 17:35:28.121256 1456 master.cpp:6660] Marking agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 at slave(325)@172.17.0.2:52206 (7612e6593663) unreachable: health check timed out I0429 17:35:28.121356 1455 hierarchical.cpp:1434] Performed allocation for 1 agents in 346812ns I0429 17:35:28.121381 1452 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.122023 1455 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.122162 1463 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.122220 1463 hierarchical.cpp:1940] No inverse offers to send out! W0429 17:35:28.122233 1456 master.cpp:6648] Not marking agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 unreachable because another unreachable transition is already in progress I0429 17:35:28.122283 1455 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:52206 I0429 17:35:28.122300 1463 hierarchical.cpp:1434] Performed allocation for 1 agents in 245154ns I0429 17:35:28.122503 1455 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.122953 1462 registrar.cpp:493] Applied 1 operations in 75218ns; attempting to update the registry I0429 17:35:28.123612 1462 registrar.cpp:550] Successfully updated the registry in 0ns I0429 17:35:28.123824 1451 master.cpp:6708] Marked agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 at slave(325)@172.17.0.2:52206 (7612e6593663) unreachable: health check timed out I0429 17:35:28.124560 1464 hierarchical.cpp:558] Removed agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 I0429 17:35:28.124748 1456 sched.cpp:959] Rescinded offer fe134f1f-7ceb-48f6-aa2d-5042310422e7-O0 I0429 17:35:28.124825 1456 sched.cpp:970] Scheduler::offerRescinded took 25197ns I0429 17:35:28.124987 1451 master.cpp:2078] Notifying framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 (default) at [email protected]:52206 of lost agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 (7612e6593663) I0429 17:35:28.125190 1458 sched.cpp:1103] Lost agent fe134f1f-7ceb-48f6-aa2d-5042310422e7-S0 I0429 17:35:28.125264 1458 sched.cpp:1114] Scheduler::slaveLost took 35857ns I0429 17:35:28.128473 1457 process.cpp:3731] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot' I0429 17:35:28.129532 1462 http.cpp:798] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot' I0429 17:35:28.158574 1431 sched.cpp:2021] Asked to stop the driver I0429 17:35:28.158743 1452 sched.cpp:1203] Stopping framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 I0429 17:35:28.159065 1456 master.cpp:7952] Processing TEARDOWN call for framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 (default) at [email protected]:52206 I0429 17:35:28.159114 1456 master.cpp:7964] Removing framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 (default) at [email protected]:52206 I0429 17:35:28.159150 1456 master.cpp:3160] Deactivating framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 (default) at [email protected]:52206 I0429 17:35:28.159641 1464 hierarchical.cpp:374] Deactivated framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 I0429 17:35:28.160405 1451 hierarchical.cpp:325] Removed framework fe134f1f-7ceb-48f6-aa2d-5042310422e7-0000 I0429 17:35:28.161954 1450 slave.cpp:790] Agent terminating I0429 17:35:28.168006 1465 master.cpp:1155] Master terminating [ OK ] PartitionTest.FailHealthChecksTwice (106 ms) [----------] 16 tests from PartitionTest (5334 ms total) [----------] 2 tests from OneWayPartitionTest [ RUN ] OneWayPartitionTest.MasterToSlave I0429 17:35:28.176699 1431 cluster.cpp:162] Creating default 'local' authorizer I0429 17:35:28.179949 1463 master.cpp:436] Master 2a754669-1272-4704-bbfe-e1bae94ab707 (7612e6593663) started on 172.17.0.2:52206 I0429 17:35:28.179993 1463 master.cpp:438] 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/EAky06/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --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="/mesos/mesos-1.3.0/_inst/share/mesos/webui" --work_dir="/tmp/EAky06/master" --zk_session_timeout="10secs" I0429 17:35:28.180302 1463 master.cpp:488] Master only allowing authenticated frameworks to register I0429 17:35:28.180316 1463 master.cpp:502] Master only allowing authenticated agents to register I0429 17:35:28.180323 1463 master.cpp:515] Master only allowing authenticated HTTP frameworks to register I0429 17:35:28.180332 1463 credentials.hpp:37] Loading credentials for authentication from '/tmp/EAky06/credentials' I0429 17:35:28.180586 1463 master.cpp:560] Using default 'crammd5' authenticator I0429 17:35:28.180721 1463 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0429 17:35:28.180919 1463 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0429 17:35:28.181099 1463 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0429 17:35:28.181442 1463 master.cpp:640] Authorization enabled I0429 17:35:28.181797 1456 hierarchical.cpp:158] Initialized hierarchical allocator process I0429 17:35:28.181810 1452 whitelist_watcher.cpp:77] No whitelist given I0429 17:35:28.184227 1457 master.cpp:2161] Elected as the leading master! I0429 17:35:28.184262 1457 master.cpp:1700] Recovering from registrar I0429 17:35:28.184506 1455 registrar.cpp:345] Recovering registrar I0429 17:35:28.185153 1455 registrar.cpp:389] Successfully fetched the registry (0B) in 599040ns I0429 17:35:28.185271 1455 registrar.cpp:493] Applied 1 operations in 21434ns; attempting to update the registry I0429 17:35:28.186046 1455 registrar.cpp:550] Successfully updated the registry in 709888ns I0429 17:35:28.186184 1455 registrar.cpp:422] Successfully recovered registrar I0429 17:35:28.186908 1452 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0429 17:35:28.186936 1461 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover I0429 17:35:28.193277 1431 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni W0429 17:35:28.193945 1431 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0429 17:35:28.194103 1431 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0429 17:35:28.194150 1431 provisioner.cpp:249] Using default backend 'copy' I0429 17:35:28.196393 1431 cluster.cpp:448] Creating default 'local' authorizer I0429 17:35:28.199136 1458 slave.cpp:225] Mesos agent started on (326)@172.17.0.2:52206 I0429 17:35:28.199167 1458 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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/OneWayPartitionTest_MasterToSlave_MR2Cq0/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_secret_key="/tmp/OneWayPartitionTest_MasterToSlave_MR2Cq0/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/OneWayPartitionTest_MasterToSlave_MR2Cq0/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/OneWayPartitionTest_MasterToSlave_MR2Cq0/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.3.0/_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/OneWayPartitionTest_MasterToSlave_MR2Cq0" --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/OneWayPartitionTest_MasterToSlave_7F6zI3" I0429 17:35:28.199757 1458 credentials.hpp:86] Loading credential for authentication from '/tmp/OneWayPartitionTest_MasterToSlave_MR2Cq0/credential' I0429 17:35:28.199990 1458 slave.cpp:258] Agent using credential for: test-principal I0429 17:35:28.200018 1458 credentials.hpp:37] Loading credentials for authentication from '/tmp/OneWayPartitionTest_MasterToSlave_MR2Cq0/http_credentials' I0429 17:35:28.200369 1458 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor' I0429 17:35:28.200500 1458 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor' I0429 17:35:28.200780 1458 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0429 17:35:28.200911 1458 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly' I0429 17:35:28.201227 1458 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0429 17:35:28.201367 1458 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite' I0429 17:35:28.203209 1458 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0429 17:35:28.203320 1458 slave.cpp:533] Agent attributes: [ ] I0429 17:35:28.203337 1458 slave.cpp:538] Agent hostname: 7612e6593663 I0429 17:35:28.203518 1463 status_update_manager.cpp:177] Pausing sending status updates I0429 17:35:28.205303 1463 state.cpp:62] Recovering state from '/tmp/OneWayPartitionTest_MasterToSlave_7F6zI3/meta' I0429 17:35:28.205683 1462 status_update_manager.cpp:203] Recovering status update manager I0429 17:35:28.205965 1450 containerizer.cpp:608] Recovering containerizer I0429 17:35:28.207690 1451 provisioner.cpp:410] Provisioner recovery complete I0429 17:35:28.208211 1454 slave.cpp:5963] Finished recovery I0429 17:35:28.208747 1454 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0429 17:35:28.209091 1461 status_update_manager.cpp:177] Pausing sending status updates I0429 17:35:28.209092 1452 slave.cpp:918] New master detected at [email protected]:52206 I0429 17:35:28.209249 1452 slave.cpp:953] Detecting new master I0429 17:35:28.209475 1452 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0429 17:35:28.210449 1459 slave.cpp:980] Authenticating with master [email protected]:52206 I0429 17:35:28.210552 1459 slave.cpp:991] Using default CRAM-MD5 authenticatee I0429 17:35:28.210855 1465 authenticatee.cpp:121] Creating new client SASL connection I0429 17:35:28.211143 1455 master.cpp:7439] Authenticating slave(326)@172.17.0.2:52206 I0429 17:35:28.211313 1462 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(713)@172.17.0.2:52206 I0429 17:35:28.211616 1451 authenticator.cpp:98] Creating new server SASL connection I0429 17:35:28.211949 1453 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0429 17:35:28.211990 1453 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0429 17:35:28.212193 1452 authenticator.cpp:204] Received SASL authentication start I0429 17:35:28.212270 1452 authenticator.cpp:326] Authentication requires more steps I0429 17:35:28.212399 1452 authenticatee.cpp:259] Received SASL authentication step I0429 17:35:28.212558 1458 authenticator.cpp:232] Received SASL authentication step I0429 17:35:28.212599 1458 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7612e6593663' server FQDN: '7612e6593663' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0429 17:35:28.212616 1458 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0429 17:35:28.212662 1458 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0429 17:35:28.212692 1458 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7612e6593663' server FQDN: '7612e6593663' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0429 17:35:28.212708 1458 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0429 17:35:28.212723 1458 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0429 17:35:28.212754 1458 authenticator.cpp:318] Authentication success I0429 17:35:28.212882 1456 authenticatee.cpp:299] Authentication success I0429 17:35:28.212954 1464 master.cpp:7469] Successfully authenticated principal 'test-principal' at slave(326)@172.17.0.2:52206 I0429 17:35:28.213040 1450 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(713)@172.17.0.2:52206 I0429 17:35:28.213495 1458 slave.cpp:1075] Successfully authenticated with master [email protected]:52206 I0429 17:35:28.213699 1458 slave.cpp:1503] Will retry registration in 2.310726ms if necessary I0429 17:35:28.213925 1456 master.cpp:5429] Received register agent message from slave(326)@172.17.0.2:52206 (7612e6593663) I0429 17:35:28.214079 1456 master.cpp:3659] Authorizing agent with principal 'test-principal' I0429 17:35:28.214665 1451 master.cpp:5546] Registering agent at slave(326)@172.17.0.2:52206 (7612e6593663) with id 2a754669-1272-4704-bbfe-e1bae94ab707-S0 I0429 17:35:28.215226 1462 registrar.cpp:493] Applied 1 operations in 70925ns; attempting to update the registry I0429 17:35:28.216060 1458 registrar.cpp:550] Successfully updated the registry in 763136ns I0429 17:35:28.216779 1457 slave.cpp:1503] Will retry registration in 21.877676ms if necessary I0429 17:35:28.217051 1457 slave.cpp:4745] Received ping from slave-observer(335)@172.17.0.2:52206 I0429 17:35:28.217057 1465 master.cpp:5621] Registered agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0429 17:35:28.217372 1457 slave.cpp:1121] Registered with master [email protected]:52206; given agent ID 2a754669-1272-4704-bbfe-e1bae94ab707-S0 I0429 17:35:28.217406 1457 fetcher.cpp:94] Clearing fetcher cache I0429 17:35:28.217561 1465 master.cpp:5429] Received register agent message from slave(326)@172.17.0.2:52206 (7612e6593663) I0429 17:35:28.217805 1465 master.cpp:3659] Authorizing agent with principal 'test-principal' I0429 17:35:28.217842 1455 status_update_manager.cpp:184] Resuming sending status updates I0429 17:35:28.217947 1459 hierarchical.cpp:525] Added agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 (7612e6593663) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0429 17:35:28.218076 1457 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/OneWayPartitionTest_MasterToSlave_7F6zI3/meta/slaves/2a754669-1272-4704-bbfe-e1bae94ab707-S0/slave.info' I0429 17:35:28.218312 1459 hierarchical.cpp:1850] No allocations performed I0429 17:35:28.218369 1454 master.cpp:1313] Agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663) disconnected I0429 17:35:28.218391 1459 hierarchical.cpp:1434] Performed allocation for 1 agents in 254851ns I0429 17:35:28.218407 1454 master.cpp:3197] Disconnecting agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663) I0429 17:35:28.218493 1454 master.cpp:3216] Deactivating agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663) I0429 17:35:28.218575 1457 slave.cpp:1187] Forwarding total oversubscribed resources {} I0429 17:35:28.218686 1458 hierarchical.cpp:653] Agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 deactivated I0429 17:35:28.218765 1454 master.cpp:5515] Removing old disconnected agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663) because a registration attempt occurred I0429 17:35:28.218811 1454 master.cpp:8317] Removing agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663): a new agent registered at the same address I0429 17:35:28.219045 1454 master.cpp:5546] Registering agent at slave(326)@172.17.0.2:52206 (7612e6593663) with id 2a754669-1272-4704-bbfe-e1bae94ab707-S1 I0429 17:35:28.219305 1461 registrar.cpp:493] Applied 1 operations in 85818ns; attempting to update the registry I0429 17:35:28.219440 1454 master.cpp:6288] Received update of agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663) with total oversubscribed resources {} I0429 17:35:28.220299 1461 registrar.cpp:550] Successfully updated the registry in 0ns I0429 17:35:28.220515 1451 master.cpp:8359] Removed agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 at slave(326)@172.17.0.2:52206 (7612e6593663): a new agent registered at the same address I0429 17:35:28.220576 1461 registrar.cpp:493] Applied 1 operations in 64729ns; attempting to update the registry I0429 17:35:28.221438 1464 hierarchical.cpp:558] Removed agent 2a754669-1272-4704-bbfe-e1bae94ab707-S0 I0429 17:35:28.221480 1461 registrar.cpp:550] Successfully updated the registry in 0ns I0429 17:35:28.222410 1452 slave.cpp:4745] Received ping from slave-observer(336)@172.17.0.2:52206 Registered but got wrong id: 2a754669-1272-4704-bbfe-e1bae94ab707-S1 (expected: 2a754669-1272-4704-bbfe-e1bae94ab707-S0). Committing suicide I0429 17:35:28.222682 1454 master.cpp:5621] Registered agent 2a754669-1272-4704-bbfe-e1bae94ab707-S1 at slave(326)@172.17.0.2:52206 (7612e6593663) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] ../../3rdparty/libprocess/include/process/gmock.hpp:214: ERROR: this mock object (used in test OneWayPartitionTest.MasterToSlave) should be deleted but never is. Its address is @0x7fc7237292b8. ../../src/tests/mock_registrar.cpp:54: ERROR: this mock object (used in test OneWayPartitionTest.MasterToSlave) should be deleted but never is. Its address is @0x7fc723739640. ERROR: 2 leaked mock objects found at program exit. make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-1.3.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.3.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.3.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.3.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1493485244-9173 Untagged: mesos-1493485244-9173:latest Deleted: sha256:5a6c3d8cac87f7e19f6f944c6b75ef52177c1816dd96bd70ee1a862e4ee4fb44 Deleted: sha256:c80445005b184ce7b722ea14722351944b5e707e9520f807056fa0142f65ee40 Deleted: sha256:66b2f44599e62c7d093e623732bc679ab8c816e2cac1c407722d69a3b742ca95 Deleted: sha256:723a766c74e3754372c82837b6f596ff16c6f2db08c00c95cde9cbbb7574f835 Deleted: sha256:a197fe5e216dd4f2a6ffbd913b8926e0b57118091412128433dedb41f22d3c16 Deleted: sha256:b0b1aca103f15c122943de5bcd1384100e37c30872f8e4290ff0be25f66569a2 Deleted: sha256:e9515768f213f7ff8ca37e33af0977584896026585dc26034ba60b3f3c60476f Deleted: sha256:b42c29f0e1f2bb965ba42b928285f04b5823f2cd1b4e04dc5cae3b3c1d601230 Deleted: sha256:8b0d951bd97ab2262bcb3744c9915b1ef06c9deeca01180e24d338fdd20f7b37 Deleted: sha256:5b50e1bfb3539f0cf63400b235d01a9b02c88fdf30cd5a56ad3340120c24e8ea Deleted: sha256:6bc42a915ef1976ddd2ddb9db2d0e4889a93ce6b304e91b1a8bc58a006e76441 Deleted: sha256:861f2b52d034241f166cc7b7360d145da3513e2f6e7f79dcc4558274abfabe62 Deleted: sha256:59c44c3e5e1d55be29888bfd680b6630d56ac3caf4ffba1f0f608dc868ef8a90 Deleted: sha256:a277bf006e230d97d794ad6e9f59f98e248e113c04898caf3fe97090f90102ff Deleted: sha256:6fbcc3f329ecc9a51d54d7ca23915b813ce0405a1bf0de8b7ced0520a5965c0d Deleted: sha256:0fbb29d2ff5e12dc26f148a311d24ae602d765f8d847d9c60b9a12a3e615f476 Deleted: sha256:4425bf7787a92544fa47c9322cfeb1c4eb7624a6e7103b18fcba6ed88daf312e Deleted: sha256:4c0fb643bf136eb6eef650351c64972c70a2ab0105f9b1c076b6b58222e9f670 Deleted: sha256:acedde42b51cef269f590022e89377239c7202c516585a0f620f2d7925de63cf Deleted: sha256:395185e709e8063c50c0b3bed1cf5c7ae2a955e798aedabdd68d6753246a1cfb Deleted: sha256:877672fac53820feb1ac93cfaf19f015c2d9c1527db04f532687fc7fda7b1a8d Deleted: sha256:317bea66d3621ff3aaff80f9c28159f34a50eda50f17175c5afbefeafa2d334a Deleted: sha256:f944872695aae15e38e7fe03e905348153ab8b35bc1df54d6ecd99e8499cc980 Deleted: sha256:d3c6475619e206ac439fe270a2f2b8ff3dad4890fb0d451623e3d185e7e6eb95 Deleted: sha256:8d70f510b5762128122a5679926247895a22ff18e3f0260fe5ac8b848dfa7724 Build step 'Execute shell' marked build as failure
