See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3338/display/redirect?page=changes>
Changes: [mpark] Removed `std::` in `src/master/master.cpp`. ------------------------------------------ [...truncated 11.94 MB...] I0304 04:19:38.125126 26242 exec.cpp:325] Executor asked to run task '1' I0304 04:19:38.125164 26242 exec.cpp:334] Executor::launchTask took 22488ns I0304 04:19:38.125205 26242 exec.cpp:551] Executor sending status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.125311 26235 slave.cpp:3813] Handling status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 from executor(120)@172.17.0.2:37094 I0304 04:19:38.125532 26242 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.125557 26242 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.125674 26242 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 to the agent I0304 04:19:38.125741 26245 slave.cpp:4253] Forwarding the update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 to [email protected]:37094 I0304 04:19:38.125844 26245 slave.cpp:4147] Status update manager successfully handled status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.125855 26240 master.cpp:6204] Status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 from agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.125864 26245 slave.cpp:4163] Sending acknowledgement for status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 to executor(120)@172.17.0.2:37094 I0304 04:19:38.125876 26240 master.cpp:6272] Forwarding status update TASK_RUNNING (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.125915 26245 exec.cpp:374] Executor received status update acknowledgement 72afddd2-c564-491f-b309-34bcb9604f31 for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.125934 26240 master.cpp:8353] Updating the state of task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0304 04:19:38.126014 26249 sched.cpp:1041] Scheduler::statusUpdate took 30214ns I0304 04:19:38.126130 26250 master.cpp:5139] Processing ACKNOWLEDGE call 72afddd2-c564-491f-b309-34bcb9604f31 for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 (default) at [email protected]:37094 on agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 I0304 04:19:38.126245 26240 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.126369 26244 slave.cpp:3102] Status update manager successfully handled status update acknowledgement (UUID: 72afddd2-c564-491f-b309-34bcb9604f31) for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.126508 26244 exec.cpp:396] Executor received framework message I0304 04:19:38.126554 26244 exec.cpp:405] Executor::frameworkMessage took 27105ns I0304 04:19:38.126986 26248 slave.cpp:4321] Sending message for framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 to [email protected]:37094 I0304 04:19:38.127058 26248 sched.cpp:1177] Scheduler::frameworkMessage took 15999ns I0304 04:19:38.127239 26234 sched.cpp:2021] Asked to stop the driver I0304 04:19:38.127290 26248 sched.cpp:1203] Stopping framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.127398 26248 master.cpp:7755] Processing TEARDOWN call for framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 (default) at [email protected]:37094 I0304 04:19:38.127420 26248 master.cpp:7767] Removing framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 (default) at [email protected]:37094 I0304 04:19:38.127434 26248 master.cpp:3136] Deactivating framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 (default) at [email protected]:37094 I0304 04:19:38.127495 26248 master.cpp:8353] Updating the state of task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0304 04:19:38.127722 26248 master.cpp:8447] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 on agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.127848 26248 master.cpp:8476] Removing executor 'default' with resources {} of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 on agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.128005 26248 hierarchical.cpp:415] Deactivated framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.128234 26248 hierarchical.cpp:1092] Recovered cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: {}) on agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 from framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.128329 26248 hierarchical.cpp:362] Removed framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.128360 26248 slave.cpp:2660] Asked to shut down framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 by [email protected]:37094 I0304 04:19:38.128377 26248 slave.cpp:2685] Shutting down framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.128391 26248 slave.cpp:5080] Shutting down executor 'default' of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 at executor(120)@172.17.0.2:37094 I0304 04:19:38.128669 26248 exec.cpp:415] Executor asked to shutdown I0304 04:19:38.128695 26248 exec.cpp:430] Executor::shutdown took 11103ns I0304 04:19:38.128798 26248 slave.cpp:4385] Got exited event for executor(120)@172.17.0.2:37094 I0304 04:19:38.129006 26244 slave.cpp:4766] Executor 'default' of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 exited with status 0 I0304 04:19:38.129040 26244 slave.cpp:4866] Cleaning up executor 'default' of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 at executor(120)@172.17.0.2:37094 W0304 04:19:38.129137 26237 master.cpp:6328] Ignoring unknown exited executor 'default' of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 on agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.129195 26248 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_pr4Npb/slaves/5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0/frameworks/5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000/executors/default/runs/ef9bb9f5-af46-4286-8d1e-684a2c31d41f' for gc 6.99999850502222days in the future I0304 04:19:38.129298 26244 slave.cpp:4954] Cleaning up framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.129338 26247 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_pr4Npb/slaves/5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0/frameworks/5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000/executors/default' for gc 6.99999850416593days in the future I0304 04:19:38.129370 26246 status_update_manager.cpp:285] Closing status update streams for framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.129410 26246 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000 I0304 04:19:38.129431 26244 slave.cpp:804] Agent terminating I0304 04:19:38.129437 26249 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_pr4Npb/slaves/5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0/frameworks/5e26991c-1ae4-4f16-8f0c-08d35216c3b8-0000' for gc 6.9999985026163days in the future I0304 04:19:38.129503 26249 master.cpp:1264] Agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) disconnected I0304 04:19:38.129519 26249 master.cpp:3173] Disconnecting agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.129551 26249 master.cpp:3192] Deactivating agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 at slave(286)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.129611 26250 hierarchical.cpp:646] Agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 deactivated I0304 04:19:38.130856 26234 master.cpp:1103] Master terminating I0304 04:19:38.131016 26237 hierarchical.cpp:551] Removed agent 5e26991c-1ae4-4f16-8f0c-08d35216c3b8-S0 [ OK ] MasterTest.FrameworkMessage (47 ms) [ RUN ] MasterTest.MultipleExecutors I0304 04:19:38.163486 26234 cluster.cpp:160] Creating default 'local' authorizer I0304 04:19:38.165267 26241 master.cpp:383] Master cdc3d216-d761-4023-8d92-5aacc35f1550 (33736a354612) started on 172.17.0.2:37094 I0304 04:19:38.165287 26241 master.cpp:385] 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/J0n9vP/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" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/J0n9vP/master" --zk_session_timeout="10secs" I0304 04:19:38.165541 26241 master.cpp:435] Master only allowing authenticated frameworks to register I0304 04:19:38.165550 26241 master.cpp:449] Master only allowing authenticated agents to register I0304 04:19:38.165556 26241 master.cpp:462] Master only allowing authenticated HTTP frameworks to register I0304 04:19:38.165562 26241 credentials.hpp:37] Loading credentials for authentication from '/tmp/J0n9vP/credentials' I0304 04:19:38.165706 26241 master.cpp:507] Using default 'crammd5' authenticator I0304 04:19:38.165756 26241 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0304 04:19:38.165794 26241 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0304 04:19:38.165817 26241 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0304 04:19:38.165838 26241 master.cpp:587] Authorization enabled I0304 04:19:38.166085 26248 whitelist_watcher.cpp:77] No whitelist given I0304 04:19:38.166096 26247 hierarchical.cpp:161] Initialized hierarchical allocator process I0304 04:19:38.166975 26241 master.cpp:2122] Elected as the leading master! I0304 04:19:38.166990 26241 master.cpp:1646] Recovering from registrar I0304 04:19:38.167153 26244 registrar.cpp:329] Recovering registrar I0304 04:19:38.167469 26244 registrar.cpp:362] Successfully fetched the registry (0B) in 292096ns I0304 04:19:38.167507 26244 registrar.cpp:461] Applied 1 operations in 4346ns; attempting to update the registry I0304 04:19:38.167944 26241 registrar.cpp:506] Successfully updated the registry in 414976ns I0304 04:19:38.167994 26241 registrar.cpp:392] Successfully recovered registrar I0304 04:19:38.168246 26239 master.cpp:1760] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0304 04:19:38.168277 26249 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover I0304 04:19:38.210522 26234 cluster.cpp:446] Creating default 'local' authorizer I0304 04:19:38.211202 26244 slave.cpp:211] Mesos agent started on (287)@172.17.0.2:37094 I0304 04:19:38.211220 26244 slave.cpp:212] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterTest_MultipleExecutors_FQ8xWE/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/MasterTest_MultipleExecutors_FQ8xWE/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/MasterTest_MultipleExecutors_FQ8xWE/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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/MasterTest_MultipleExecutors_FQ8xWE" --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/MasterTest_MultipleExecutors_x5M8af" I0304 04:19:38.211624 26244 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_FQ8xWE/credential' I0304 04:19:38.211730 26244 slave.cpp:354] Agent using credential for: test-principal I0304 04:19:38.211748 26244 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_FQ8xWE/http_credentials' I0304 04:19:38.211871 26244 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0304 04:19:38.211925 26244 http.cpp:933] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0304 04:19:38.211971 26234 sched.cpp:232] Version: 1.3.0 I0304 04:19:38.212133 26247 sched.cpp:336] New master detected at [email protected]:37094 I0304 04:19:38.212167 26247 sched.cpp:407] Authenticating with master [email protected]:37094 I0304 04:19:38.212175 26247 sched.cpp:414] Using default CRAM-MD5 authenticatee I0304 04:19:38.212271 26247 authenticatee.cpp:121] Creating new client SASL connection I0304 04:19:38.212404 26244 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0304 04:19:38.212442 26247 master.cpp:7213] Authenticating [email protected]:37094 I0304 04:19:38.212448 26244 slave.cpp:549] Agent attributes: [ ] I0304 04:19:38.212477 26244 slave.cpp:554] Agent hostname: 33736a354612 I0304 04:19:38.212520 26237 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(635)@172.17.0.2:37094 I0304 04:19:38.212538 26247 status_update_manager.cpp:177] Pausing sending status updates I0304 04:19:38.212628 26245 authenticator.cpp:98] Creating new server SASL connection I0304 04:19:38.212766 26247 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0304 04:19:38.212793 26247 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0304 04:19:38.212838 26247 authenticator.cpp:204] Received SASL authentication start I0304 04:19:38.212893 26247 authenticator.cpp:326] Authentication requires more steps I0304 04:19:38.212916 26237 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_x5M8af/meta' I0304 04:19:38.215747 26240 status_update_manager.cpp:203] Recovering status update manager I0304 04:19:38.215865 26240 slave.cpp:5568] Finished recovery I0304 04:19:38.216279 26240 slave.cpp:5750] Querying resource estimator for oversubscribable resources I0304 04:19:38.216411 26240 slave.cpp:932] New master detected at [email protected]:37094 I0304 04:19:38.216457 26240 slave.cpp:967] Detecting new master I0304 04:19:38.216492 26240 slave.cpp:5764] Received oversubscribable resources {} from the resource estimator I0304 04:19:38.216521 26240 status_update_manager.cpp:177] Pausing sending status updates I0304 04:19:38.216591 26247 authenticatee.cpp:259] Received SASL authentication step I0304 04:19:38.216655 26247 authenticator.cpp:232] Received SASL authentication step I0304 04:19:38.216680 26247 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '33736a354612' server FQDN: '33736a354612' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0304 04:19:38.216689 26247 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0304 04:19:38.216704 26247 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0304 04:19:38.216714 26247 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '33736a354612' server FQDN: '33736a354612' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0304 04:19:38.216722 26247 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0304 04:19:38.216729 26247 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0304 04:19:38.216744 26247 authenticator.cpp:318] Authentication success I0304 04:19:38.216799 26247 authenticatee.cpp:299] Authentication success I0304 04:19:38.216828 26247 master.cpp:7243] Successfully authenticated principal 'test-principal' at [email protected]:37094 I0304 04:19:38.216857 26247 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(635)@172.17.0.2:37094 I0304 04:19:38.216939 26247 sched.cpp:513] Successfully authenticated with master [email protected]:37094 I0304 04:19:38.216950 26247 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:37094 I0304 04:19:38.216989 26247 sched.cpp:869] Will retry registration in 1.457584864secs if necessary I0304 04:19:38.217078 26247 master.cpp:2790] Received SUBSCRIBE call for framework 'default' at [email protected]:37094 I0304 04:19:38.217106 26247 master.cpp:2158] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0304 04:19:38.217236 26247 master.cpp:2867] Subscribing framework default with checkpointing disabled and capabilities [ ] I0304 04:19:38.217437 26247 hierarchical.cpp:286] Added framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.217486 26247 hierarchical.cpp:1838] No allocations performed I0304 04:19:38.217499 26247 hierarchical.cpp:1928] No inverse offers to send out! I0304 04:19:38.217511 26247 hierarchical.cpp:1422] Performed allocation for 0 agents in 32387ns I0304 04:19:38.217545 26243 sched.cpp:759] Framework registered with cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.217579 26243 sched.cpp:773] Scheduler::registered took 15715ns I0304 04:19:38.227679 26237 slave.cpp:994] Authenticating with master [email protected]:37094 I0304 04:19:38.227744 26237 slave.cpp:1005] Using default CRAM-MD5 authenticatee I0304 04:19:38.227851 26237 authenticatee.cpp:121] Creating new client SASL connection I0304 04:19:38.228073 26237 master.cpp:7213] Authenticating slave(287)@172.17.0.2:37094 I0304 04:19:38.228134 26237 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(636)@172.17.0.2:37094 I0304 04:19:38.228209 26237 authenticator.cpp:98] Creating new server SASL connection I0304 04:19:38.228337 26237 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0304 04:19:38.228360 26237 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0304 04:19:38.228399 26237 authenticator.cpp:204] Received SASL authentication start I0304 04:19:38.228449 26237 authenticator.cpp:326] Authentication requires more steps I0304 04:19:38.228488 26237 authenticatee.cpp:259] Received SASL authentication step I0304 04:19:38.228533 26237 authenticator.cpp:232] Received SASL authentication step I0304 04:19:38.228556 26237 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '33736a354612' server FQDN: '33736a354612' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0304 04:19:38.228569 26237 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0304 04:19:38.228585 26237 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0304 04:19:38.228596 26237 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '33736a354612' server FQDN: '33736a354612' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0304 04:19:38.228605 26237 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0304 04:19:38.228615 26237 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0304 04:19:38.228629 26237 authenticator.cpp:318] Authentication success I0304 04:19:38.228672 26237 authenticatee.cpp:299] Authentication success I0304 04:19:38.228706 26237 master.cpp:7243] Successfully authenticated principal 'test-principal' at slave(287)@172.17.0.2:37094 I0304 04:19:38.228736 26237 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(636)@172.17.0.2:37094 I0304 04:19:38.228817 26237 slave.cpp:1089] Successfully authenticated with master [email protected]:37094 I0304 04:19:38.228896 26237 slave.cpp:1517] Will retry registration in 12.065525ms if necessary I0304 04:19:38.229045 26237 master.cpp:5425] Registering agent at slave(287)@172.17.0.2:37094 (33736a354612) with id cdc3d216-d761-4023-8d92-5aacc35f1550-S0 I0304 04:19:38.229202 26237 registrar.cpp:461] Applied 1 operations in 20697ns; attempting to update the registry I0304 04:19:38.229658 26237 registrar.cpp:506] Successfully updated the registry in 422912ns I0304 04:19:38.229926 26237 master.cpp:5499] Registered agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0304 04:19:38.230090 26237 hierarchical.cpp:518] Added agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 (33736a354612) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0304 04:19:38.230435 26237 hierarchical.cpp:1928] No inverse offers to send out! I0304 04:19:38.230456 26237 hierarchical.cpp:1422] Performed allocation for 1 agents in 305094ns I0304 04:19:38.230494 26237 slave.cpp:1135] Registered with master [email protected]:37094; given agent ID cdc3d216-d761-4023-8d92-5aacc35f1550-S0 I0304 04:19:38.230509 26237 fetcher.cpp:94] Clearing fetcher cache I0304 04:19:38.230849 26237 slave.cpp:1163] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_x5M8af/meta/slaves/cdc3d216-d761-4023-8d92-5aacc35f1550-S0/slave.info' I0304 04:19:38.231148 26237 slave.cpp:1201] Forwarding total oversubscribed resources {} I0304 04:19:38.231197 26237 slave.cpp:4343] Received ping from slave-observer(281)@172.17.0.2:37094 I0304 04:19:38.231390 26237 master.cpp:7042] Sending 1 offers to framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 (default) at [email protected]:37094 I0304 04:19:38.231468 26237 master.cpp:6059] Received update of agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) with total oversubscribed resources {} I0304 04:19:38.231544 26237 status_update_manager.cpp:184] Resuming sending status updates I0304 04:19:38.231788 26237 sched.cpp:933] Scheduler::resourceOffers took 51119ns I0304 04:19:38.235502 26246 master.cpp:3827] Processing ACCEPT call for offers: [ cdc3d216-d761-4023-8d92-5aacc35f1550-O0 ] on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) for framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 (default) at [email protected]:37094 I0304 04:19:38.235566 26246 master.cpp:3403] Authorizing framework principal 'test-principal' to launch task 1 I0304 04:19:38.235692 26246 master.cpp:3403] Authorizing framework principal 'test-principal' to launch task 2 W0304 04:19:38.251803 26245 validation.cpp:1104] Executor 'executor-1' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0304 04:19:38.251858 26245 validation.cpp:1116] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0304 04:19:38.251971 26245 master.cpp:9105] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.252045 26245 master.cpp:4477] Launching task 1 of framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 (default) at [email protected]:37094 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.252300 26246 slave.cpp:1627] Got assigned task '1' for framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 W0304 04:19:38.252430 26245 validation.cpp:1104] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0304 04:19:38.252450 26245 validation.cpp:1116] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0304 04:19:38.252543 26245 master.cpp:9105] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.252619 26246 slave.cpp:1787] Launching task '1' for framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.252604 26245 master.cpp:4477] Launching task 2 of framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 (default) at [email protected]:37094 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 at slave(287)@172.17.0.2:37094 (33736a354612) I0304 04:19:38.253235 26246 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_x5M8af/slaves/cdc3d216-d761-4023-8d92-5aacc35f1550-S0/frameworks/cdc3d216-d761-4023-8d92-5aacc35f1550-0000/executors/executor-1/runs/d1953ed7-760e-478d-83d5-79b1f65cb149' to user 'mesos' I0304 04:19:38.253346 26245 hierarchical.cpp:835] Updated allocation of framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 from cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] to cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] I0304 04:19:38.253451 26246 slave.cpp:6498] Launching executor 'executor-1' of framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_x5M8af/slaves/cdc3d216-d761-4023-8d92-5aacc35f1550-S0/frameworks/cdc3d216-d761-4023-8d92-5aacc35f1550-0000/executors/executor-1/runs/d1953ed7-760e-478d-83d5-79b1f65cb149' I0304 04:19:38.253528 26245 hierarchical.cpp:1092] Recovered ports(*)(allocated: *):[31000-32000]; disk(*)(allocated: *):1024 (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024) on agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 from framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.253561 26245 hierarchical.cpp:1129] Framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 filtered agent cdc3d216-d761-4023-8d92-5aacc35f1550-S0 for 5secs I0304 04:19:38.253670 26246 slave.cpp:2120] Queued task '1' for executor 'executor-1' of framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.253763 26246 slave.cpp:1627] Got assigned task '2' for framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.253993 26246 slave.cpp:885] Successfully attached file '/tmp/MasterTest_MultipleExecutors_x5M8af/slaves/cdc3d216-d761-4023-8d92-5aacc35f1550-S0/frameworks/cdc3d216-d761-4023-8d92-5aacc35f1550-0000/executors/executor-1/runs/d1953ed7-760e-478d-83d5-79b1f65cb149' I0304 04:19:38.254025 26246 slave.cpp:1787] Launching task '2' for framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 I0304 04:19:38.254393 26246 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_x5M8af/slaves/cdc3d216-d761-4023-8d92-5aacc35f1550-S0/frameworks/cdc3d216-d761-4023-8d92-5aacc35f1550-0000/executors/executor-2/runs/c455ef5c-f453-46c9-b256-97c4f488deed' to user 'mesos' I0304 04:19:38.254549 26246 slave.cpp:6498] Launching executor 'executor-2' of framework cdc3d216-d761-4023-8d92-5aacc35f1550-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_x5M8af/slaves/cdc3d216-d761-4023-8d92-5aacc35f1550-S0/frameworks/cdc3d216-d761-4023-8d92-5aacc35f1550-0000/executors/executor-2/runs/c455ef5c-f453-46c9-b256-97c4f488deed' *** Aborted at 1488601178 (unix time) try "date -d @1488601178" if you are using GNU date *** I0304 04:19:38.254784 26245 exec.cpp:162] Version: 1.3.0 PC: @ 0x2b49905a882d (unknown) *** SIGSEGV (@0xd0) received by PID 26234 (TID 0x2b4999af9700) from PID 208; stack trace: *** I0304 04:19:38.255084 26245 exec.cpp:212] Executor started at: executor(121)@172.17.0.2:37094 with pid 26234 @ 0x2b498fb3f330 (unknown) @ 0x2b49905a882d (unknown) @ 0x2b498d084244 mesos::internal::slave::executorEnvironment() @ 0x2b498d0afda3 mesos::internal::slave::Framework::launchExecutor() @ 0x2b498d0b2ce7 mesos::internal::slave::Slave::_run() @ 0x2b498e354f81 process::ProcessManager::resume() @ 0x2b498e35de27 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2b498fdfea60 (unknown) @ 0x2b498fb37184 start_thread @ 0x2b499066737d (unknown) make[3]: *** [CMakeFiles/check] Segmentation fault make[3]: Leaving directory `/mesos/build' make[2]: Leaving directory `/mesos/build' make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make[1]: Leaving directory `/mesos/build' make: *** [check] Error 2 + docker rmi mesos-1488596522-13439 Untagged: mesos-1488596522-13439:latest Deleted: sha256:1d533cc85a49475ed8e0f24d00ac97e2584e68fdc866f7484ab5e95af5306d10 Deleted: sha256:943c0ede5f1a0a998d158ec004eaad486e1e13a6bbd292e3f661288125fdb6d3 Deleted: sha256:7450fffb19326b327d6760fe5fdbf3d565ae6f303ef38fec8c2cebb19b9aa56b Deleted: sha256:df3a3134840019ac87ed9953e57c048b3a52d2bbeef67a4514fa2810ba052f9c Deleted: sha256:b3a6a581b7b41ec6b02b1a58ce4bedb0ed9a9186ff68d53affc214cc9877501d Deleted: sha256:0f49a44f998782c377f88a22a44d683dd9548c08318e61914177608d021ba57d Deleted: sha256:e7a7c31b4ec0bb4a2d5226d3bca9d01082bc2f02cbd2f1631df738e8b014e178 Deleted: sha256:70486784eea8d7394edb1a0e5dc5825158c7777a27de63935f3e8e5c115261c4 Deleted: sha256:43c7ee5bc71b02377b8a6a97d6bc60e955e4a3eafac164ee83e073bcb9a7b7bb Deleted: sha256:967d962adae091260deb28eb5c395dd9f6c6266541627f9a907d41ac392267cc Deleted: sha256:6e505ffd761e5dc28da2bef58e654470d93f9a27d7b5b513115a0eef952294a2 Deleted: sha256:7aee9c5e0f461ab59d86d2d30abf46f43b532cc23f889dcb2239c740f0e601f6 Deleted: sha256:7a8f5daaa0d8e5ba83d3cf4307229680ed279c1cfb80414e0dd6fd48cf8bb4d4 Deleted: sha256:86303f0e8b159f08f0d627a7fb3975b02bc9054022a13756f07ea3ebed74a559 Deleted: sha256:df15e4fa7d46c862aee593f4974972aa5941e25e5f174f13a8ec6400c71eeaad Deleted: sha256:de170d3857ab43a66d1ff5e7a9009c440fc78f90d003d400604d1477cb42312d Deleted: sha256:f97428850a4413d17c91145f23572792b5b234c8825718cb10de973cb43d10b6 Deleted: sha256:fb98699c37fb09fb438b8a7ecde2b1b567862c2fe8d978199c6e4c2fac12a277 Deleted: sha256:e7bd9f9d9827bce6f149223629d0cce97926ded0f15bbf6cc2c6753ce2c91435 Deleted: sha256:2322c2cc85a99d5f4bcabd5c2ad749de09002f9c3b3ee87700034bda9c0323bb Deleted: sha256:02c8140dee5ae5e03a3eb54e08d19b7080331c714e2c1ddc77ee138632e9ce75 Deleted: sha256:68bfd29d4b147f4ea6f2cdb4df4fbaa36b984e9f04a7a4a6f8b1d9de96fae409 Deleted: sha256:a43531d97a987180c658ad1cedaeadcba5af6c7a7d971d2317dbe5169f7a244a Deleted: sha256:8c194110469d364cfae6f1dbd027ea418067f3176d840c6715e32addcccbd451 Build step 'Execute shell' marked build as failure
