See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3599/display/redirect?page=changes>
Changes: [haosdent] Added Pinterest to 'powered by mesos' list. ------------------------------------------ [...truncated 14.76 MB...] I0503 09:03:32.983018 31686 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0503 09:03:32.983050 31686 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0503 09:03:32.983175 31693 authenticator.cpp:204] Received SASL authentication start I0503 09:03:32.983234 31693 authenticator.cpp:326] Authentication requires more steps I0503 09:03:32.983340 31693 authenticatee.cpp:259] Received SASL authentication step I0503 09:03:32.983500 31686 authenticator.cpp:232] Received SASL authentication step I0503 09:03:32.983537 31686 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6efac503eac0' server FQDN: '6efac503eac0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0503 09:03:32.983557 31686 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0503 09:03:32.983602 31686 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0503 09:03:32.983633 31686 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6efac503eac0' server FQDN: '6efac503eac0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0503 09:03:32.983651 31686 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0503 09:03:32.983669 31686 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0503 09:03:32.983693 31686 authenticator.cpp:318] Authentication success I0503 09:03:32.983786 31693 authenticatee.cpp:299] Authentication success I0503 09:03:32.983839 31682 master.cpp:7469] Successfully authenticated principal 'test-principal' at slave(325)@172.17.0.2:39681 I0503 09:03:32.983935 31689 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(713)@172.17.0.2:39681 I0503 09:03:32.984235 31685 slave.cpp:1075] Successfully authenticated with master [email protected]:39681 I0503 09:03:32.984395 31685 slave.cpp:1503] Will retry registration in 2.655271ms if necessary I0503 09:03:32.984542 31686 master.cpp:5429] Received register agent message from slave(325)@172.17.0.2:39681 (6efac503eac0) I0503 09:03:32.984683 31686 master.cpp:3659] Authorizing agent with principal 'test-principal' I0503 09:03:32.985116 31683 master.cpp:5546] Registering agent at slave(325)@172.17.0.2:39681 (6efac503eac0) with id 4926361b-cd1c-4166-a563-357c389793ba-S0 I0503 09:03:32.985532 31681 registrar.cpp:493] Applied 1 operations in 57382ns; attempting to update the registry I0503 09:03:32.986119 31681 registrar.cpp:550] Successfully updated the registry in 529152ns I0503 09:03:32.986881 31688 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:32.986982 31690 master.cpp:5621] Registered agent 4926361b-cd1c-4166-a563-357c389793ba-S0 at slave(325)@172.17.0.2:39681 (6efac503eac0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0503 09:03:32.987085 31688 slave.cpp:1121] Registered with master [email protected]:39681; given agent ID 4926361b-cd1c-4166-a563-357c389793ba-S0 I0503 09:03:32.987110 31688 fetcher.cpp:94] Clearing fetcher cache I0503 09:03:32.987246 31689 status_update_manager.cpp:184] Resuming sending status updates I0503 09:03:32.987381 31692 hierarchical.cpp:525] Added agent 4926361b-cd1c-4166-a563-357c389793ba-S0 (6efac503eac0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0503 09:03:32.987491 31688 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/PartitionTest_FailHealthChecksTwice_fBAsnG/meta/slaves/4926361b-cd1c-4166-a563-357c389793ba-S0/slave.info' I0503 09:03:32.987829 31688 slave.cpp:1187] Forwarding total oversubscribed resources {} I0503 09:03:32.987980 31682 master.cpp:6288] Received update of agent 4926361b-cd1c-4166-a563-357c389793ba-S0 at slave(325)@172.17.0.2:39681 (6efac503eac0) with total oversubscribed resources {} I0503 09:03:32.988677 31692 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:32.988736 31692 hierarchical.cpp:1434] Performed allocation for 1 agents in 1.231512ms I0503 09:03:32.989297 31694 master.cpp:7269] Sending 1 offers to framework 4926361b-cd1c-4166-a563-357c389793ba-0000 (default) at [email protected]:39681 I0503 09:03:32.989781 31682 sched.cpp:933] Scheduler::resourceOffers took 63259ns I0503 09:03:32.992310 31693 hierarchical.cpp:1850] No allocations performed I0503 09:03:32.992377 31693 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:32.992485 31693 hierarchical.cpp:1434] Performed allocation for 1 agents in 344670ns I0503 09:03:32.992607 31690 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0503 09:03:32.992751 31690 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:32.992943 31690 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:32.994545 31687 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0503 09:03:32.994695 31687 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:32.994850 31687 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:32.995219 31684 hierarchical.cpp:1850] No allocations performed I0503 09:03:32.995280 31684 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:32.995365 31684 hierarchical.cpp:1434] Performed allocation for 1 agents in 317036ns I0503 09:03:32.997051 31682 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0503 09:03:32.997167 31693 hierarchical.cpp:1850] No allocations performed I0503 09:03:32.997220 31693 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:32.997220 31682 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:32.997350 31693 hierarchical.cpp:1434] Performed allocation for 1 agents in 281801ns I0503 09:03:32.997424 31682 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:32.999150 31696 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0503 09:03:32.999243 31695 hierarchical.cpp:1850] No allocations performed I0503 09:03:32.999303 31695 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:32.999292 31696 slave.cpp:5659] Current disk usage 22.42%. Max allowed age: 4.730377894880972days I0503 09:03:32.999377 31695 hierarchical.cpp:1434] Performed allocation for 1 agents in 250725ns I0503 09:03:32.999542 31696 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:32.999701 31696 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:33.001363 31692 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0503 09:03:33.001569 31688 hierarchical.cpp:1850] No allocations performed I0503 09:03:33.001590 31692 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:33.001627 31688 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:33.001647 31682 master.cpp:6660] Marking agent 4926361b-cd1c-4166-a563-357c389793ba-S0 at slave(325)@172.17.0.2:39681 (6efac503eac0) unreachable: health check timed out I0503 09:03:33.001756 31688 hierarchical.cpp:1434] Performed allocation for 1 agents in 300146ns I0503 09:03:33.001853 31692 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:33.003896 31685 hierarchical.cpp:1850] No allocations performed I0503 09:03:33.003960 31685 hierarchical.cpp:1940] No inverse offers to send out! I0503 09:03:33.004016 31685 hierarchical.cpp:1434] Performed allocation for 1 agents in 260215ns I0503 09:03:33.004214 31686 slave.cpp:6145] Querying resource estimator for oversubscribable resources W0503 09:03:33.004359 31689 master.cpp:6648] Not marking agent 4926361b-cd1c-4166-a563-357c389793ba-S0 unreachable because another unreachable transition is already in progress I0503 09:03:33.004400 31686 slave.cpp:4745] Received ping from slave-observer(334)@172.17.0.2:39681 I0503 09:03:33.004679 31688 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:33.005105 31686 registrar.cpp:493] Applied 1 operations in 88675ns; attempting to update the registry I0503 09:03:33.005986 31686 registrar.cpp:550] Successfully updated the registry in 0ns I0503 09:03:33.006276 31691 master.cpp:6708] Marked agent 4926361b-cd1c-4166-a563-357c389793ba-S0 at slave(325)@172.17.0.2:39681 (6efac503eac0) unreachable: health check timed out I0503 09:03:33.007259 31690 sched.cpp:959] Rescinded offer 4926361b-cd1c-4166-a563-357c389793ba-O0 I0503 09:03:33.007339 31692 hierarchical.cpp:558] Removed agent 4926361b-cd1c-4166-a563-357c389793ba-S0 I0503 09:03:33.007345 31690 sched.cpp:970] Scheduler::offerRescinded took 29080ns I0503 09:03:33.007676 31691 master.cpp:2078] Notifying framework 4926361b-cd1c-4166-a563-357c389793ba-0000 (default) at [email protected]:39681 of lost agent 4926361b-cd1c-4166-a563-357c389793ba-S0 (6efac503eac0) I0503 09:03:33.007897 31682 sched.cpp:1103] Lost agent 4926361b-cd1c-4166-a563-357c389793ba-S0 I0503 09:03:33.008010 31682 sched.cpp:1114] Scheduler::slaveLost took 39637ns I0503 09:03:33.012189 31690 process.cpp:3731] Handling HTTP event for process 'metrics' with path: '/metrics/snapshot' I0503 09:03:33.013286 31696 http.cpp:798] Authorizing principal 'ANY' to GET the endpoint '/metrics/snapshot' I0503 09:03:33.041735 31662 sched.cpp:2021] Asked to stop the driver I0503 09:03:33.042054 31692 sched.cpp:1203] Stopping framework 4926361b-cd1c-4166-a563-357c389793ba-0000 I0503 09:03:33.042410 31685 master.cpp:7952] Processing TEARDOWN call for framework 4926361b-cd1c-4166-a563-357c389793ba-0000 (default) at [email protected]:39681 I0503 09:03:33.042479 31685 master.cpp:7964] Removing framework 4926361b-cd1c-4166-a563-357c389793ba-0000 (default) at [email protected]:39681 I0503 09:03:33.042502 31685 master.cpp:3160] Deactivating framework 4926361b-cd1c-4166-a563-357c389793ba-0000 (default) at [email protected]:39681 I0503 09:03:33.042915 31684 hierarchical.cpp:374] Deactivated framework 4926361b-cd1c-4166-a563-357c389793ba-0000 I0503 09:03:33.043437 31693 hierarchical.cpp:325] Removed framework 4926361b-cd1c-4166-a563-357c389793ba-0000 I0503 09:03:33.044163 31694 slave.cpp:790] Agent terminating I0503 09:03:33.049501 31681 master.cpp:1155] Master terminating [ OK ] PartitionTest.FailHealthChecksTwice (110 ms) [----------] 16 tests from PartitionTest (19358 ms total) [----------] 2 tests from OneWayPartitionTest [ RUN ] OneWayPartitionTest.MasterToSlave I0503 09:03:33.059231 31662 cluster.cpp:162] Creating default 'local' authorizer I0503 09:03:33.063010 31686 master.cpp:436] Master e6dc1a8c-fdf7-4464-9c81-c7120b3855d1 (6efac503eac0) started on 172.17.0.2:39681 I0503 09:03:33.063048 31686 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/bKnOFr/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.4.0/_inst/share/mesos/webui" --work_dir="/tmp/bKnOFr/master" --zk_session_timeout="10secs" I0503 09:03:33.063581 31686 master.cpp:488] Master only allowing authenticated frameworks to register I0503 09:03:33.063606 31686 master.cpp:502] Master only allowing authenticated agents to register I0503 09:03:33.063630 31686 master.cpp:515] Master only allowing authenticated HTTP frameworks to register I0503 09:03:33.063650 31686 credentials.hpp:37] Loading credentials for authentication from '/tmp/bKnOFr/credentials' I0503 09:03:33.064149 31686 master.cpp:560] Using default 'crammd5' authenticator I0503 09:03:33.064357 31686 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0503 09:03:33.064605 31686 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0503 09:03:33.064853 31686 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0503 09:03:33.065042 31686 master.cpp:640] Authorization enabled I0503 09:03:33.065286 31683 whitelist_watcher.cpp:77] No whitelist given I0503 09:03:33.065295 31696 hierarchical.cpp:158] Initialized hierarchical allocator process I0503 09:03:33.068650 31694 master.cpp:2161] Elected as the leading master! I0503 09:03:33.068691 31694 master.cpp:1700] Recovering from registrar I0503 09:03:33.068905 31690 registrar.cpp:345] Recovering registrar I0503 09:03:33.069800 31690 registrar.cpp:389] Successfully fetched the registry (0B) in 844800ns I0503 09:03:33.069926 31690 registrar.cpp:493] Applied 1 operations in 24232ns; attempting to update the registry I0503 09:03:33.070600 31690 registrar.cpp:550] Successfully updated the registry in 605952ns I0503 09:03:33.070735 31690 registrar.cpp:422] Successfully recovered registrar I0503 09:03:33.071401 31682 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover I0503 09:03:33.071404 31684 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0503 09:03:33.078032 31662 containerizer.cpp:221] Using isolation: posix/cpu,posix/mem,filesystem/posix,network/cni W0503 09:03:33.078688 31662 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0503 09:03:33.078809 31662 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0503 09:03:33.078850 31662 provisioner.cpp:249] Using default backend 'copy' I0503 09:03:33.080750 31662 cluster.cpp:448] Creating default 'local' authorizer I0503 09:03:33.082870 31688 slave.cpp:225] Mesos agent started on (326)@172.17.0.2:39681 I0503 09:03:33.082900 31688 slave.cpp:226] 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/OneWayPartitionTest_MasterToSlave_XihCJk/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/OneWayPartitionTest_MasterToSlave_XihCJk/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_XihCJk/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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_XihCJk" --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_l8xHcT" I0503 09:03:33.083413 31688 credentials.hpp:86] Loading credential for authentication from '/tmp/OneWayPartitionTest_MasterToSlave_XihCJk/credential' I0503 09:03:33.083588 31688 slave.cpp:258] Agent using credential for: test-principal I0503 09:03:33.083614 31688 credentials.hpp:37] Loading credentials for authentication from '/tmp/OneWayPartitionTest_MasterToSlave_XihCJk/http_credentials' I0503 09:03:33.083897 31688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0503 09:03:33.084054 31688 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0503 09:03:33.085803 31688 slave.cpp:525] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0503 09:03:33.085912 31688 slave.cpp:533] Agent attributes: [ ] I0503 09:03:33.085928 31688 slave.cpp:538] Agent hostname: 6efac503eac0 I0503 09:03:33.086089 31691 status_update_manager.cpp:177] Pausing sending status updates I0503 09:03:33.087993 31689 state.cpp:62] Recovering state from '/tmp/OneWayPartitionTest_MasterToSlave_l8xHcT/meta' I0503 09:03:33.088380 31684 status_update_manager.cpp:203] Recovering status update manager I0503 09:03:33.088687 31688 containerizer.cpp:608] Recovering containerizer I0503 09:03:33.090600 31694 provisioner.cpp:410] Provisioner recovery complete I0503 09:03:33.091042 31686 slave.cpp:5963] Finished recovery I0503 09:03:33.091550 31686 slave.cpp:6145] Querying resource estimator for oversubscribable resources I0503 09:03:33.091964 31694 status_update_manager.cpp:177] Pausing sending status updates I0503 09:03:33.091966 31682 slave.cpp:918] New master detected at [email protected]:39681 I0503 09:03:33.092084 31682 slave.cpp:953] Detecting new master I0503 09:03:33.092259 31682 slave.cpp:6159] Received oversubscribable resources {} from the resource estimator I0503 09:03:33.095392 31686 slave.cpp:980] Authenticating with master [email protected]:39681 I0503 09:03:33.095489 31686 slave.cpp:991] Using default CRAM-MD5 authenticatee I0503 09:03:33.095755 31681 authenticatee.cpp:121] Creating new client SASL connection I0503 09:03:33.096048 31688 master.cpp:7439] Authenticating slave(326)@172.17.0.2:39681 I0503 09:03:33.096190 31696 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(714)@172.17.0.2:39681 I0503 09:03:33.096470 31695 authenticator.cpp:98] Creating new server SASL connection I0503 09:03:33.096720 31683 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0503 09:03:33.096753 31683 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0503 09:03:33.096880 31681 authenticator.cpp:204] Received SASL authentication start I0503 09:03:33.096966 31681 authenticator.cpp:326] Authentication requires more steps I0503 09:03:33.097087 31681 authenticatee.cpp:259] Received SASL authentication step I0503 09:03:33.097329 31696 authenticator.cpp:232] Received SASL authentication step I0503 09:03:33.097368 31696 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6efac503eac0' server FQDN: '6efac503eac0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0503 09:03:33.097388 31696 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0503 09:03:33.097436 31696 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0503 09:03:33.097470 31696 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '6efac503eac0' server FQDN: '6efac503eac0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0503 09:03:33.097486 31696 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0503 09:03:33.097497 31696 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0503 09:03:33.097518 31696 authenticator.cpp:318] Authentication success I0503 09:03:33.097645 31683 authenticatee.cpp:299] Authentication success I0503 09:03:33.097692 31686 master.cpp:7469] Successfully authenticated principal 'test-principal' at slave(326)@172.17.0.2:39681 I0503 09:03:33.097903 31693 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(714)@172.17.0.2:39681 I0503 09:03:33.098208 31686 slave.cpp:1075] Successfully authenticated with master [email protected]:39681 I0503 09:03:33.098475 31686 slave.cpp:1503] Will retry registration in 1.945436ms if necessary I0503 09:03:33.098652 31691 master.cpp:5429] Received register agent message from slave(326)@172.17.0.2:39681 (6efac503eac0) I0503 09:03:33.098819 31691 master.cpp:3659] Authorizing agent with principal 'test-principal' I0503 09:03:33.099356 31689 master.cpp:5546] Registering agent at slave(326)@172.17.0.2:39681 (6efac503eac0) with id e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 I0503 09:03:33.099885 31692 registrar.cpp:493] Applied 1 operations in 66646ns; attempting to update the registry I0503 09:03:33.100651 31692 registrar.cpp:550] Successfully updated the registry in 698112ns I0503 09:03:33.101037 31688 slave.cpp:1503] Will retry registration in 18.267617ms if necessary I0503 09:03:33.101616 31689 slave.cpp:4745] Received ping from slave-observer(335)@172.17.0.2:39681 I0503 09:03:33.101632 31682 master.cpp:5621] Registered agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0503 09:03:33.101994 31689 slave.cpp:1121] Registered with master [email protected]:39681; given agent ID e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 I0503 09:03:33.102025 31689 fetcher.cpp:94] Clearing fetcher cache I0503 09:03:33.102146 31682 master.cpp:5429] Received register agent message from slave(326)@172.17.0.2:39681 (6efac503eac0) I0503 09:03:33.102280 31685 hierarchical.cpp:525] Added agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 (6efac503eac0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0503 09:03:33.102313 31682 master.cpp:3659] Authorizing agent with principal 'test-principal' I0503 09:03:33.102555 31692 status_update_manager.cpp:184] Resuming sending status updates I0503 09:03:33.102689 31689 slave.cpp:1149] Checkpointing SlaveInfo to '/tmp/OneWayPartitionTest_MasterToSlave_l8xHcT/meta/slaves/e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0/slave.info' I0503 09:03:33.102913 31685 hierarchical.cpp:1850] No allocations performed I0503 09:03:33.102957 31694 master.cpp:1313] Agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0) disconnected I0503 09:03:33.102996 31694 master.cpp:3197] Disconnecting agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0) I0503 09:03:33.103027 31685 hierarchical.cpp:1434] Performed allocation for 1 agents in 385112ns I0503 09:03:33.103118 31694 master.cpp:3216] Deactivating agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0) I0503 09:03:33.103171 31689 slave.cpp:1187] Forwarding total oversubscribed resources {} I0503 09:03:33.103313 31690 hierarchical.cpp:653] Agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 deactivated I0503 09:03:33.103423 31694 master.cpp:5515] Removing old disconnected agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0) because a registration attempt occurred I0503 09:03:33.103471 31694 master.cpp:8317] Removing agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0): a new agent registered at the same address I0503 09:03:33.103719 31694 master.cpp:5546] Registering agent at slave(326)@172.17.0.2:39681 (6efac503eac0) with id e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S1 I0503 09:03:33.103951 31686 registrar.cpp:493] Applied 1 operations in 84981ns; attempting to update the registry I0503 09:03:33.104161 31694 master.cpp:6288] Received update of agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0) with total oversubscribed resources {} I0503 09:03:33.104985 31686 registrar.cpp:550] Successfully updated the registry in 0ns I0503 09:03:33.105216 31684 master.cpp:8359] Removed agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 at slave(326)@172.17.0.2:39681 (6efac503eac0): a new agent registered at the same address I0503 09:03:33.105352 31686 registrar.cpp:493] Applied 1 operations in 94863ns; attempting to update the registry I0503 09:03:33.106053 31694 hierarchical.cpp:558] Removed agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0 I0503 09:03:33.106086 31686 registrar.cpp:550] Successfully updated the registry in 0ns I0503 09:03:33.107033 31694 slave.cpp:4745] Received ping from slave-observer(336)@172.17.0.2:39681 I0503 09:03:33.107192 31695 master.cpp:5621] Registered agent e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S1 at slave(326)@172.17.0.2:39681 (6efac503eac0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] Registered but got wrong id: e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S1 (expected: e6dc1a8c-fdf7-4464-9c81-c7120b3855d1-S0). Committing suicide ../../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 @0x7f857b2a3ee8. ../../src/tests/mock_registrar.cpp:54: ERROR: this mock object (used in test OneWayPartitionTest.MasterToSlave) should be deleted but never is. Its address is @0x7f857b2d1fb0. ERROR: 2 leaked mock objects found at program exit. make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.4.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1493799742-4479 Untagged: mesos-1493799742-4479:latest Deleted: sha256:d5d94961baf8a7bac8310edca75507f65d53571ecc006567cb51f2f2325a3959 Deleted: sha256:b984c3d5dbca235ee2aa63e565d449b365b8004ffa9b045a06ac7920613f61bd Deleted: sha256:834b7164df4d6dd6bd310b8c7fe52fc2d4876003f50670ff70ff14008ba0dc51 Deleted: sha256:4fc211ddfe42a1d57dd8f45f0585cb720bd2a53a0f252970bb2c69e2e27dffea Deleted: sha256:4955aa48d281d037506298ab99bf9d08fbcd7772ed8cacbb91e22f8c4b08657e Deleted: sha256:8ed378e3b53fe92013d67842653bf45b289f8a206d0b2c795de93861b2b419c8 Deleted: sha256:971de7d734bc12548d5821c7a4ae3ca72a497f45fe517537501e1c3982a7803c Deleted: sha256:19693ae8e57436efdb6789256c724d1fc3a7091e81630afc6b92dfd50802d041 Deleted: sha256:a4d9b15fdb13b1159b9b64ad29d798bab09c09405225a4cbe6cb04ed8e59977b Deleted: sha256:3f194e3dfb231114f80a4a3d2b554cc480c409968a681ec2ad5501ca13e55ed5 Deleted: sha256:9742d4a18f991872707f2cb75d4b74f257474ac3c57c57f43f7b209fb93b9e2d Deleted: sha256:2822aa757359fb6770188163a168a837efc879025b1b213c74697f8096f65727 Deleted: sha256:6a0b3dfe84554ad912cb5ca6474a3adbc9dedeb2b2ac4e4f4bd410d209139fc1 Deleted: sha256:33e684c078ba5abe285a575354f3352a3fe30a36a09319c71bcda65299ce26dc Deleted: sha256:c0f7127dbaa131eb3e6e2c122676e5bbd04e2b6a9af4372e7028962c0f35b340 Deleted: sha256:bd55ac079bafa404aad4b2866f6df3dcf2cbebd0fc9ed1ff9f5a25c276f4979e Deleted: sha256:98ac59c23455c03dcbcf00ba0b34819da12c640271d7ac892419cf9517183d8a Deleted: sha256:5ca5808be4c767487b265a9c716d50552f2aa4513d32de760edb3e439cd985bc Deleted: sha256:cb859bcd32e0c89daab177cafd67305997d30f56dad7a3f798a1bcecdbb1c7b0 Deleted: sha256:2a7fd64f2226dad38769c3c4ca469af4c6d417ef8b6b33edc90cea91a6ba2c8c Deleted: sha256:64114f324a5f61f29701ee7ae62a20292796231c0cd7bd47b7645692bc13b263 Deleted: sha256:3bcccdda709a4a712e23dd019a0da1683734a6a2c2a9633d3849d1841223076e Deleted: sha256:91daf42b540fcf73337b5969e6a064a2dd475cce82476680f87ef0fd85ac762e Deleted: sha256:8db59d03110a8588adcb85c64deef39764e79ef54ee675b6271f58550ffe6baa Deleted: sha256:47cd80e388d7fb64d6570f80804c1440fa0dfecbe413caae35458cf4d0021b07 Build step 'Execute shell' marked build as failure
