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=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3364/display/redirect?page=changes>
Changes: [anand] Fixed indentation in process.cpp. [alexr] Added `Containerizer::remove`. [alexr] Introduced proto changes needed for the RemoveNestedContainer API call. [alexr] Introduced changes to the authz protos needed for RemoveNestedContainer. [alexr] Made the usage of C++ namespaces in "slave/http.cpp" consistent. [alexr] Implemented the Agent API call `RemoveNestedContainer`. [alexr] Added documentation for the 'RemoveNestedContainer' Agent API call. [alexr] Removed unnecessary curly braces wrapping case statements. ------------------------------------------ [...truncated 10.79 MB...] I0313 19:14:06.803449 32709 status_update_manager.cpp:395] Received status update acknowledgement (UUID: a8f5dea8-0f71-4b50-b19e-faeedcec96c0) for task 1 of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.803658 32720 exec.cpp:396] Executor received framework message I0313 19:14:06.803773 32720 exec.cpp:405] Executor::frameworkMessage took 79956ns I0313 19:14:06.803864 32711 slave.cpp:3106] Status update manager successfully handled status update acknowledgement (UUID: a8f5dea8-0f71-4b50-b19e-faeedcec96c0) for task 1 of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.804500 32719 slave.cpp:4325] Sending message for framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 to [email protected]:36284 I0313 19:14:06.804771 32719 sched.cpp:1177] Scheduler::frameworkMessage took 75219ns I0313 19:14:06.805310 32689 sched.cpp:2021] Asked to stop the driver I0313 19:14:06.805418 32711 sched.cpp:1203] Stopping framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.805713 32723 master.cpp:7765] Processing TEARDOWN call for framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 (default) at [email protected]:36284 I0313 19:14:06.805753 32723 master.cpp:7777] Removing framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 (default) at [email protected]:36284 I0313 19:14:06.805785 32723 master.cpp:3148] Deactivating framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 (default) at [email protected]:36284 I0313 19:14:06.806076 32717 hierarchical.cpp:376] Deactivated framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.806174 32708 slave.cpp:2664] Asked to shut down framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 by [email protected]:36284 I0313 19:14:06.806183 32723 master.cpp:8345] Updating the state of task 1 of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0313 19:14:06.806237 32708 slave.cpp:2689] Shutting down framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.806303 32708 slave.cpp:5076] Shutting down executor 'default' of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 at executor(74)@172.17.0.3:36284 I0313 19:14:06.806433 32714 exec.cpp:415] Executor asked to shutdown I0313 19:14:06.806493 32714 exec.cpp:430] Executor::shutdown took 26157ns I0313 19:14:06.807109 32710 slave.cpp:4389] Got exited event for executor(74)@172.17.0.3:36284 I0313 19:14:06.807580 32723 master.cpp:8439] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 on agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 at slave(179)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.807901 32712 hierarchical.cpp:1108] 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 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 from framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.808260 32723 master.cpp:8468] Removing executor 'default' with resources {} of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 on agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 at slave(179)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.808544 32713 slave.cpp:4762] Executor 'default' of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 exited with status 0 I0313 19:14:06.808681 32713 slave.cpp:4862] Cleaning up executor 'default' of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 at executor(74)@172.17.0.3:36284 I0313 19:14:06.809116 32719 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_Ke940K/slaves/47dc8a66-5b2e-4888-8220-805bacff6cab-S0/frameworks/47dc8a66-5b2e-4888-8220-805bacff6cab-0000/executors/default/runs/6b2b1858-f1f9-491c-b320-1b7c820791dc' for gc 6.99999063798519days in the future I0313 19:14:06.809201 32713 slave.cpp:4950] Cleaning up framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.809372 32710 hierarchical.cpp:323] Removed framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.809415 32715 status_update_manager.cpp:285] Closing status update streams for framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 W0313 19:14:06.809442 32723 master.cpp:6367] Ignoring unknown exited executor 'default' of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 on agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 at slave(179)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.809507 32719 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_Ke940K/slaves/47dc8a66-5b2e-4888-8220-805bacff6cab-S0/frameworks/47dc8a66-5b2e-4888-8220-805bacff6cab-0000/executors/default' for gc 6.99999063503407days in the future I0313 19:14:06.809522 32715 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 47dc8a66-5b2e-4888-8220-805bacff6cab-0000 I0313 19:14:06.809887 32714 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_Ke940K/slaves/47dc8a66-5b2e-4888-8220-805bacff6cab-S0/frameworks/47dc8a66-5b2e-4888-8220-805bacff6cab-0000' for gc 6.99999062714074days in the future I0313 19:14:06.809926 32713 slave.cpp:808] Agent terminating I0313 19:14:06.810174 32712 master.cpp:1317] Agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 at slave(179)@172.17.0.3:36284 (15f529e648a6) disconnected I0313 19:14:06.810201 32712 master.cpp:3185] Disconnecting agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 at slave(179)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.810281 32712 master.cpp:3204] Deactivating agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 at slave(179)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.810446 32722 hierarchical.cpp:655] Agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 deactivated I0313 19:14:06.813172 32716 master.cpp:1156] Master terminating I0313 19:14:06.813853 32717 hierarchical.cpp:560] Removed agent 47dc8a66-5b2e-4888-8220-805bacff6cab-S0 [ OK ] MasterTest.FrameworkMessage (84 ms) [ RUN ] MasterTest.MultipleExecutors I0313 19:14:06.822197 32689 cluster.cpp:160] Creating default 'local' authorizer I0313 19:14:06.824661 32718 master.cpp:437] Master d831cc82-06a3-43a2-b3a3-dff09de9dc9f (15f529e648a6) started on 172.17.0.3:36284 I0313 19:14:06.824781 32718 master.cpp:439] 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/9f6NkO/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="/mesos/mesos-1.3.0/_inst/share/mesos/webui" --work_dir="/tmp/9f6NkO/master" --zk_session_timeout="10secs" I0313 19:14:06.825358 32718 master.cpp:489] Master only allowing authenticated frameworks to register I0313 19:14:06.825384 32718 master.cpp:503] Master only allowing authenticated agents to register I0313 19:14:06.825402 32718 master.cpp:516] Master only allowing authenticated HTTP frameworks to register I0313 19:14:06.825419 32718 credentials.hpp:37] Loading credentials for authentication from '/tmp/9f6NkO/credentials' I0313 19:14:06.825829 32718 master.cpp:561] Using default 'crammd5' authenticator I0313 19:14:06.825984 32718 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0313 19:14:06.826174 32718 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0313 19:14:06.826326 32718 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0313 19:14:06.826474 32718 master.cpp:641] Authorization enabled I0313 19:14:06.826632 32715 hierarchical.cpp:159] Initialized hierarchical allocator process I0313 19:14:06.826642 32714 whitelist_watcher.cpp:77] No whitelist given I0313 19:14:06.829313 32719 master.cpp:2165] Elected as the leading master! I0313 19:14:06.829344 32719 master.cpp:1704] Recovering from registrar I0313 19:14:06.829483 32713 registrar.cpp:331] Recovering registrar I0313 19:14:06.830235 32713 registrar.cpp:364] Successfully fetched the registry (0B) in 702208ns I0313 19:14:06.830345 32713 registrar.cpp:463] Applied 1 operations in 21507ns; attempting to update the registry I0313 19:14:06.831488 32713 registrar.cpp:508] Successfully updated the registry in 1.078016ms I0313 19:14:06.831625 32713 registrar.cpp:394] Successfully recovered registrar I0313 19:14:06.832207 32711 master.cpp:1803] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0313 19:14:06.832265 32720 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0313 19:14:06.836910 32689 cluster.cpp:446] Creating default 'local' authorizer I0313 19:14:06.838994 32708 slave.cpp:215] Mesos agent started on (180)@172.17.0.3:36284 I0313 19:14:06.839023 32708 slave.cpp:216] 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_NtwRhQ/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_NtwRhQ/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_NtwRhQ/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" --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_NtwRhQ" --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_4Nckjk" I0313 19:14:06.839696 32708 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_NtwRhQ/credential' I0313 19:14:06.839840 32708 slave.cpp:358] Agent using credential for: test-principal I0313 19:14:06.839859 32708 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_NtwRhQ/http_credentials' I0313 19:14:06.840131 32708 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0313 19:14:06.840282 32708 http.cpp:964] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0313 19:14:06.840339 32689 sched.cpp:232] Version: 1.3.0 I0313 19:14:06.841054 32721 sched.cpp:336] New master detected at [email protected]:36284 I0313 19:14:06.841171 32721 sched.cpp:407] Authenticating with master [email protected]:36284 I0313 19:14:06.841195 32721 sched.cpp:414] Using default CRAM-MD5 authenticatee I0313 19:14:06.841460 32714 authenticatee.cpp:121] Creating new client SASL connection I0313 19:14:06.841737 32713 master.cpp:7252] Authenticating [email protected]:36284 I0313 19:14:06.841886 32719 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(413)@172.17.0.3:36284 I0313 19:14:06.841856 32708 slave.cpp:545] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0313 19:14:06.841949 32708 slave.cpp:553] Agent attributes: [ ] I0313 19:14:06.841964 32708 slave.cpp:558] Agent hostname: 15f529e648a6 I0313 19:14:06.842160 32709 authenticator.cpp:98] Creating new server SASL connection I0313 19:14:06.842198 32712 status_update_manager.cpp:177] Pausing sending status updates I0313 19:14:06.842490 32715 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0313 19:14:06.842532 32715 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0313 19:14:06.842672 32719 authenticator.cpp:204] Received SASL authentication start I0313 19:14:06.842859 32719 authenticator.cpp:326] Authentication requires more steps I0313 19:14:06.843029 32711 authenticatee.cpp:259] Received SASL authentication step I0313 19:14:06.843189 32711 authenticator.cpp:232] Received SASL authentication step I0313 19:14:06.843225 32711 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '15f529e648a6' server FQDN: '15f529e648a6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0313 19:14:06.843348 32711 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0313 19:14:06.843407 32711 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0313 19:14:06.843463 32711 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '15f529e648a6' server FQDN: '15f529e648a6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0313 19:14:06.843484 32711 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0313 19:14:06.843499 32711 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0313 19:14:06.843523 32711 authenticator.cpp:318] Authentication success I0313 19:14:06.843698 32723 authenticatee.cpp:299] Authentication success I0313 19:14:06.843703 32714 master.cpp:7282] Successfully authenticated principal 'test-principal' at [email protected]:36284 I0313 19:14:06.843845 32722 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_4Nckjk/meta' I0313 19:14:06.843884 32717 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(413)@172.17.0.3:36284 I0313 19:14:06.844243 32715 sched.cpp:513] Successfully authenticated with master [email protected]:36284 I0313 19:14:06.844274 32715 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:36284 I0313 19:14:06.844311 32713 status_update_manager.cpp:203] Recovering status update manager I0313 19:14:06.844482 32715 sched.cpp:869] Will retry registration in 1.113404816secs if necessary I0313 19:14:06.844650 32723 master.cpp:2817] Received SUBSCRIBE call for framework 'default' at [email protected]:36284 I0313 19:14:06.844804 32723 master.cpp:2201] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0313 19:14:06.844921 32708 slave.cpp:5564] Finished recovery I0313 19:14:06.845469 32719 master.cpp:2894] Subscribing framework default with checkpointing disabled and capabilities [ ] I0313 19:14:06.845521 32708 slave.cpp:5746] Querying resource estimator for oversubscribable resources I0313 19:14:06.845855 32713 slave.cpp:936] New master detected at [email protected]:36284 I0313 19:14:06.845878 32720 status_update_manager.cpp:177] Pausing sending status updates I0313 19:14:06.845991 32713 slave.cpp:971] Detecting new master I0313 19:14:06.846251 32713 slave.cpp:5760] Received oversubscribable resources {} from the resource estimator I0313 19:14:06.846271 32710 sched.cpp:759] Framework registered with d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.846315 32723 hierarchical.cpp:271] Added framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.846330 32710 sched.cpp:773] Scheduler::registered took 31640ns I0313 19:14:06.846499 32723 hierarchical.cpp:1854] No allocations performed I0313 19:14:06.846556 32723 hierarchical.cpp:1944] No inverse offers to send out! I0313 19:14:06.846631 32723 hierarchical.cpp:1438] Performed allocation for 0 agents in 187094ns I0313 19:14:06.853346 32721 slave.cpp:998] Authenticating with master [email protected]:36284 I0313 19:14:06.853466 32721 slave.cpp:1009] Using default CRAM-MD5 authenticatee I0313 19:14:06.853693 32708 authenticatee.cpp:121] Creating new client SASL connection I0313 19:14:06.853950 32721 master.cpp:7252] Authenticating slave(180)@172.17.0.3:36284 I0313 19:14:06.854161 32720 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(414)@172.17.0.3:36284 I0313 19:14:06.854401 32712 authenticator.cpp:98] Creating new server SASL connection I0313 19:14:06.854609 32716 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0313 19:14:06.854636 32716 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0313 19:14:06.854745 32716 authenticator.cpp:204] Received SASL authentication start I0313 19:14:06.854813 32716 authenticator.cpp:326] Authentication requires more steps I0313 19:14:06.854914 32716 authenticatee.cpp:259] Received SASL authentication step I0313 19:14:06.855027 32716 authenticator.cpp:232] Received SASL authentication step I0313 19:14:06.855058 32716 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '15f529e648a6' server FQDN: '15f529e648a6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0313 19:14:06.855080 32716 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0313 19:14:06.855129 32716 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0313 19:14:06.855167 32716 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '15f529e648a6' server FQDN: '15f529e648a6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0313 19:14:06.855185 32716 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0313 19:14:06.855192 32716 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0313 19:14:06.855211 32716 authenticator.cpp:318] Authentication success I0313 19:14:06.855370 32716 authenticatee.cpp:299] Authentication success I0313 19:14:06.855458 32716 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.3:36284 I0313 19:14:06.855556 32716 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(414)@172.17.0.3:36284 I0313 19:14:06.855855 32716 slave.cpp:1093] Successfully authenticated with master [email protected]:36284 I0313 19:14:06.856051 32716 slave.cpp:1521] Will retry registration in 1.49768ms if necessary I0313 19:14:06.856366 32716 master.cpp:5437] Registering agent at slave(180)@172.17.0.3:36284 (15f529e648a6) with id d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 I0313 19:14:06.856863 32715 registrar.cpp:463] Applied 1 operations in 61824ns; attempting to update the registry I0313 19:14:06.858383 32715 registrar.cpp:508] Successfully updated the registry in 1.410048ms I0313 19:14:06.858647 32711 slave.cpp:1521] Will retry registration in 8.935017ms if necessary I0313 19:14:06.858858 32708 master.cpp:5425] Ignoring register agent message from slave(180)@172.17.0.3:36284 (15f529e648a6) as admission is already in progress I0313 19:14:06.859647 32709 slave.cpp:4347] Received ping from slave-observer(177)@172.17.0.3:36284 I0313 19:14:06.859730 32708 master.cpp:5511] Registered agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0313 19:14:06.859858 32709 slave.cpp:1139] Registered with master [email protected]:36284; given agent ID d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 I0313 19:14:06.859886 32709 fetcher.cpp:94] Clearing fetcher cache I0313 19:14:06.860011 32721 hierarchical.cpp:527] Added agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 (15f529e648a6) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0313 19:14:06.860062 32711 status_update_manager.cpp:184] Resuming sending status updates I0313 19:14:06.860332 32709 slave.cpp:1167] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_4Nckjk/meta/slaves/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0/slave.info' I0313 19:14:06.860832 32709 slave.cpp:1205] Forwarding total oversubscribed resources {} I0313 19:14:06.861011 32709 master.cpp:6098] Received update of agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) with total oversubscribed resources {} I0313 19:14:06.861292 32721 hierarchical.cpp:1944] No inverse offers to send out! I0313 19:14:06.861361 32721 hierarchical.cpp:1438] Performed allocation for 1 agents in 1.215605ms I0313 19:14:06.861742 32718 master.cpp:7081] Sending 1 offers to framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 (default) at [email protected]:36284 I0313 19:14:06.862323 32723 sched.cpp:933] Scheduler::resourceOffers took 146545ns I0313 19:14:06.865097 32711 master.cpp:3839] Processing ACCEPT call for offers: [ d831cc82-06a3-43a2-b3a3-dff09de9dc9f-O0 ] on agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) for framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 (default) at [email protected]:36284 I0313 19:14:06.865237 32711 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 1 I0313 19:14:06.865622 32711 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 2 W0313 19:14:06.868243 32721 validation.cpp:1113] 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. W0313 19:14:06.868286 32721 validation.cpp:1125] 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. I0313 19:14:06.868929 32721 master.cpp:9097] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.869199 32721 master.cpp:4489] Launching task 1 of framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 (default) at [email protected]:36284 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.869706 32712 slave.cpp:1631] Got assigned task '1' for framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.870364 32712 slave.cpp:1791] Launching task '1' for framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 W0313 19:14:06.870656 32721 validation.cpp:1113] 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. W0313 19:14:06.870695 32721 validation.cpp:1125] 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. I0313 19:14:06.870941 32712 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_4Nckjk/slaves/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0/frameworks/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000/executors/executor-1/runs/44cef36a-0412-4ab1-befc-77a6f023b41d' to user 'mesos' I0313 19:14:06.871196 32712 slave.cpp:6491] Launching executor 'executor-1' of framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_4Nckjk/slaves/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0/frameworks/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000/executors/executor-1/runs/44cef36a-0412-4ab1-befc-77a6f023b41d' I0313 19:14:06.871178 32721 master.cpp:9097] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.871462 32721 master.cpp:4489] Launching task 2 of framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 (default) at [email protected]:36284 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 at slave(180)@172.17.0.3:36284 (15f529e648a6) I0313 19:14:06.871706 32712 slave.cpp:2124] Queued task '1' for executor 'executor-1' of framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.871779 32712 slave.cpp:889] Successfully attached file '/tmp/MasterTest_MultipleExecutors_4Nckjk/slaves/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0/frameworks/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000/executors/executor-1/runs/44cef36a-0412-4ab1-befc-77a6f023b41d' I0313 19:14:06.872251 32712 slave.cpp:1631] Got assigned task '2' for framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.872715 32712 slave.cpp:1791] Launching task '2' for framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.873153 32712 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_4Nckjk/slaves/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0/frameworks/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000/executors/executor-2/runs/320d2968-d054-45a3-b6df-6ed4f97b74c8' to user 'mesos' I0313 19:14:06.873366 32712 slave.cpp:6491] Launching executor 'executor-2' of framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_4Nckjk/slaves/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0/frameworks/d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000/executors/executor-2/runs/320d2968-d054-45a3-b6df-6ed4f97b74c8' *** Aborted at 1489432446 (unix time) try "date -d @1489432446" if you are using GNU date *** PC: @ 0x2b88f798382d (unknown) I0313 19:14:06.873967 32717 exec.cpp:162] Version: 1.3.0 *** SIGSEGV (@0x31) received by PID 32689 (TID 0x2b8900eca700) from PID 49; stack trace: *** I0313 19:14:06.874264 32718 exec.cpp:212] Executor started at: executor(75)@172.17.0.3:36284 with pid 32689 I0313 19:14:06.874822 32709 hierarchical.cpp:844] Updated allocation of framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 on agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-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] I0313 19:14:06.875435 32709 hierarchical.cpp:1108] 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 d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 from framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 I0313 19:14:06.875489 32709 hierarchical.cpp:1145] Framework d831cc82-06a3-43a2-b3a3-dff09de9dc9f-0000 filtered agent d831cc82-06a3-43a2-b3a3-dff09de9dc9f-S0 for 5secs @ 0x2b894979c2d7 (unknown) @ 0x2b89497a05b9 (unknown) @ 0x2b88f773a330 (unknown) @ 0x2b88f798382d (unknown) @ 0x2b88ed0bb4d6 os::getenv() @ 0x2b88f4255e5d mesos::internal::slave::executorEnvironment() @ 0x2b88f4250620 mesos::internal::slave::Framework::launchExecutor() @ 0x2b88f422a5d9 mesos::internal::slave::Slave::_run() @ 0x2b88f4284605 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureIbEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSF_INS1_13TaskGroupInfoEES6_S9_SC_SH_SL_EEvRKNS_3PIDIT_EEMSP_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES16_ @ 0x2b88f42ba1a1 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureIbEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSJ_INS5_13TaskGroupInfoEESA_SD_SG_SL_SP_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_ @ 0x2b88f5025031 std::function<>::operator()() @ 0x2b88f500adf9 process::ProcessBase::visit() @ 0x2b88f5015732 process::DispatchEvent::visit() @ 0x2b88ed08f886 process::ProcessBase::serve() @ 0x2b88f50070e6 process::ProcessManager::resume() @ 0x2b88f500392a _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv @ 0x2b88f5014e6c _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE @ 0x2b88f5014dc3 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv @ 0x2b88f5014d5c _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2b88f6fbba60 (unknown) @ 0x2b88f7732184 start_thread @ 0x2b88f7a4237d (unknown) make[4]: *** [check-local] Segmentation fault 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-1489429334-5466 Untagged: mesos-1489429334-5466:latest Deleted: sha256:108e8d9da38be7bcdb24605dcbef2c7243c0e66a088747b1fed6b1d67efde7d2 Deleted: sha256:abbe5714064cc50582e13364752a68dfc8da0baa060ed8e266ca9c73dcadc4d0 Deleted: sha256:655e30b2168c3e2565aae76500c179939bccb26e38f45d96e05e0ea0fd220153 Deleted: sha256:0cfa181bb7786b0d0702bcf420bad60b6344372e21b78ce7d99d9c47e8c601d7 Deleted: sha256:b7bc3baf689547044c93e45e2a60b1dcd33e6cc5ce3dfd406ba827965d17d92e Deleted: sha256:71a42290a293ff7ab70265071f21fdc1fd6d5d1f10e22c079f5a4ff752135f20 Deleted: sha256:3eb779b7e8ba1eb8f2c350bbb119c826cc4f0ca6233e73987a61e81fbbfc4d64 Deleted: sha256:d8cc3414d6e62f3c63f41185ed5aff81e186084ed7bebc3ec5eeeaf1b3d66666 Deleted: sha256:b3cb9d94eeb877eac5582e889b24dab276d260ffc595c7a6e03376f6e36b1f00 Deleted: sha256:bb1fad5939299fa4808e4ffc205e91521a8f589483d9a38258600ae8c36b75f0 Deleted: sha256:39364c6876c7335233ee61d68ef458fcd3563f61ae0b73b02fcfd95c479ab956 Deleted: sha256:bc3cf4aa9468ad9cacb0725f5fbdd162846eb9a54a224bc432c2fc40b53672be Deleted: sha256:4f1c1f44dcb2f833278b8e82876ca37bd4e2ae911b770455b42ac99a4fcc5d8e Deleted: sha256:f634431f1f9beb7303f04036ead2821e860a270f2290358b2b815d83a8988969 Deleted: sha256:71d986a3d371f58ec4a6bb616a6319a2504a8ae1f8d410291f94e7a93a9207da Deleted: sha256:93061fe5d20880d5002766f3997c58e0fab5f52baf9dd2821012a91d4661df12 Deleted: sha256:a802adc2640b4e86304fe2a00ffd51ec40b96720e7837081b46e107d442e9fc5 Deleted: sha256:f031122a0ea885ed65f3f120bd0c460692a2e26e727ebb11e000fbe48516b852 Deleted: sha256:ef975a94d5eb36f102cd5b732b1f66d0700ef96be5550db6c1d042b960c03f52 Deleted: sha256:f10df2fc64688aa9a7f6400195f4e83660403e61a8dc24a650fa9163298cd734 Deleted: sha256:b3cd7fb9c83b025f878954ef5b95fa45454f9a7628455b3fcf36eabbaf6a3d53 Deleted: sha256:b8b9a407119cc51bbe3dde950d89054906f6a11d3a5f909329a76ca7d7f86a07 Deleted: sha256:fc07fc7a5252eb2eafd352cb65f08e56a00c8f1c19783f7c0b9561fe46eec170 Deleted: sha256:0449268046a05d1014176b509b6570ff45005983a4711674b97fb457ad9cbb8c Build step 'Execute shell' marked build as failure
