See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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)/3430/display/redirect?page=changes>
Changes: [alexr] Fixed a typo in the website Readme. ------------------------------------------ [...truncated 12.41 MB...] I0329 13:18:24.584471 26727 slave.cpp:4523] Sending acknowledgement for status update TASK_RUNNING (UUID: 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f) for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 to executor(120)@172.17.0.3:38742 I0329 13:18:24.584538 26734 exec.cpp:374] Executor received status update acknowledgement 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.584564 26745 master.cpp:6243] Status update TASK_RUNNING (UUID: 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f) for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 from agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.584597 26745 master.cpp:6311] Forwarding status update TASK_RUNNING (UUID: 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f) for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.584672 26745 master.cpp:8345] Updating the state of task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0329 13:18:24.584771 26739 sched.cpp:1041] Scheduler::statusUpdate took 55724ns I0329 13:18:24.584920 26724 master.cpp:5151] Processing ACKNOWLEDGE call 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 (default) at [email protected]:38742 on agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 I0329 13:18:24.585244 26743 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f) for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.585312 26745 exec.cpp:396] Executor received framework message I0329 13:18:24.585429 26745 exec.cpp:405] Executor::frameworkMessage took 106833ns I0329 13:18:24.585475 26730 slave.cpp:3462] Status update manager successfully handled status update acknowledgement (UUID: 8bb67d92-2f3d-4d1b-aa99-7f22e0e1d26f) for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.585788 26730 slave.cpp:4681] Sending message for framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 to [email protected]:38742 I0329 13:18:24.585988 26741 sched.cpp:1177] Scheduler::frameworkMessage took 55006ns I0329 13:18:24.586190 26723 sched.cpp:2021] Asked to stop the driver I0329 13:18:24.586256 26742 sched.cpp:1203] Stopping framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.586354 26732 master.cpp:7765] Processing TEARDOWN call for framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 (default) at [email protected]:38742 I0329 13:18:24.586370 26732 master.cpp:7777] Removing framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 (default) at [email protected]:38742 I0329 13:18:24.586386 26732 master.cpp:3148] Deactivating framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 (default) at [email protected]:38742 I0329 13:18:24.586446 26732 master.cpp:8345] Updating the state of task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0329 13:18:24.586454 26746 hierarchical.cpp:376] Deactivated framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.586465 26734 slave.cpp:3015] Asked to shut down framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 by [email protected]:38742 I0329 13:18:24.586483 26734 slave.cpp:3040] Shutting down framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.586499 26734 slave.cpp:5433] Shutting down executor 'default' of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 at executor(120)@172.17.0.3:38742 I0329 13:18:24.586690 26739 hierarchical.cpp:1116] 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 479e27dc-3bd0-4457-af67-e558fef4955e-S0 from framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.586726 26731 exec.cpp:415] Executor asked to shutdown I0329 13:18:24.586691 26732 master.cpp:8439] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 on agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.586766 26731 exec.cpp:430] Executor::shutdown took 24461ns I0329 13:18:24.586833 26732 master.cpp:8468] Removing executor 'default' with resources {} of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 on agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.587024 26731 slave.cpp:4745] Got exited event for executor(120)@172.17.0.3:38742 I0329 13:18:24.587031 26740 hierarchical.cpp:323] Removed framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.587549 26731 slave.cpp:5119] Executor 'default' of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 exited with status 0 I0329 13:18:24.587822 26731 slave.cpp:5219] Cleaning up executor 'default' of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 at executor(120)@172.17.0.3:38742 W0329 13:18:24.587882 26738 master.cpp:6367] Ignoring unknown exited executor 'default' of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 on agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.588024 26747 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_7sj3A1/slaves/479e27dc-3bd0-4457-af67-e558fef4955e-S0/frameworks/479e27dc-3bd0-4457-af67-e558fef4955e-0000/executors/default/runs/99692cdc-7f0f-409c-89d9-d49f4632ca26' for gc 6.99999319520889days in the future I0329 13:18:24.588042 26731 slave.cpp:5307] Cleaning up framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.588107 26747 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_7sj3A1/slaves/479e27dc-3bd0-4457-af67-e558fef4955e-S0/frameworks/479e27dc-3bd0-4457-af67-e558fef4955e-0000/executors/default' for gc 6.99999319415407days in the future I0329 13:18:24.588243 26741 status_update_manager.cpp:285] Closing status update streams for framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.588263 26741 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 479e27dc-3bd0-4457-af67-e558fef4955e-0000 I0329 13:18:24.588275 26731 slave.cpp:748] Agent terminating I0329 13:18:24.588289 26733 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_7sj3A1/slaves/479e27dc-3bd0-4457-af67-e558fef4955e-S0/frameworks/479e27dc-3bd0-4457-af67-e558fef4955e-0000' for gc 6.99999319191111days in the future I0329 13:18:24.588414 26746 master.cpp:1317] Agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) disconnected I0329 13:18:24.588430 26746 master.cpp:3185] Disconnecting agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.588465 26746 master.cpp:3204] Deactivating agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 at slave(295)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.588531 26735 hierarchical.cpp:655] Agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 deactivated I0329 13:18:24.590023 26738 master.cpp:1156] Master terminating I0329 13:18:24.590193 26741 hierarchical.cpp:560] Removed agent 479e27dc-3bd0-4457-af67-e558fef4955e-S0 [ OK ] MasterTest.FrameworkMessage (34 ms) [ RUN ] MasterTest.MultipleExecutors I0329 13:18:24.595479 26723 cluster.cpp:160] Creating default 'local' authorizer I0329 13:18:24.596837 26733 master.cpp:437] Master be7284e7-ed26-4163-aafa-532c0c06a1e5 (2fe01027e182) started on 172.17.0.3:38742 I0329 13:18:24.596863 26733 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/wRbgOi/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/wRbgOi/master" --zk_session_timeout="10secs" I0329 13:18:24.597054 26733 master.cpp:489] Master only allowing authenticated frameworks to register I0329 13:18:24.597060 26733 master.cpp:503] Master only allowing authenticated agents to register I0329 13:18:24.597064 26733 master.cpp:516] Master only allowing authenticated HTTP frameworks to register I0329 13:18:24.597069 26733 credentials.hpp:37] Loading credentials for authentication from '/tmp/wRbgOi/credentials' I0329 13:18:24.597192 26733 master.cpp:561] Using default 'crammd5' authenticator I0329 13:18:24.597236 26733 http.cpp:976] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0329 13:18:24.597357 26733 http.cpp:976] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0329 13:18:24.597506 26733 http.cpp:976] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0329 13:18:24.597561 26733 master.cpp:641] Authorization enabled I0329 13:18:24.597697 26732 whitelist_watcher.cpp:77] No whitelist given I0329 13:18:24.597721 26740 hierarchical.cpp:159] Initialized hierarchical allocator process I0329 13:18:24.598366 26732 master.cpp:2165] Elected as the leading master! I0329 13:18:24.598384 26732 master.cpp:1704] Recovering from registrar I0329 13:18:24.598449 26745 registrar.cpp:331] Recovering registrar I0329 13:18:24.598772 26734 registrar.cpp:364] Successfully fetched the registry (0B) in 299008ns I0329 13:18:24.598809 26734 registrar.cpp:463] Applied 1 operations in 7485ns; attempting to update the registry I0329 13:18:24.599088 26739 registrar.cpp:508] Successfully updated the registry in 257024ns I0329 13:18:24.599138 26739 registrar.cpp:394] Successfully recovered registrar I0329 13:18:24.599383 26735 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0329 13:18:24.599385 26744 master.cpp:1803] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0329 13:18:24.602061 26723 cluster.cpp:446] Creating default 'local' authorizer I0329 13:18:24.602691 26738 slave.cpp:226] Mesos agent started on (296)@172.17.0.3:38742 I0329 13:18:24.602715 26738 slave.cpp:227] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterTest_MultipleExecutors_Yhu9wr/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io"; --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_secret_key="secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_Yhu9wr/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/MasterTest_MultipleExecutors_Yhu9wr/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_Yhu9wr" --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_l4mHan" I0329 13:18:24.602988 26738 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_Yhu9wr/credential' I0329 13:18:24.603072 26738 slave.cpp:259] Agent using credential for: test-principal I0329 13:18:24.603087 26738 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_Yhu9wr/http_credentials' I0329 13:18:24.603183 26738 http.cpp:976] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor' I0329 13:18:24.603224 26738 http.cpp:997] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor' I0329 13:18:24.603297 26738 http.cpp:976] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0329 13:18:24.603416 26738 http.cpp:997] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly' I0329 13:18:24.603467 26723 sched.cpp:232] Version: 1.3.0 I0329 13:18:24.603502 26738 http.cpp:976] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0329 13:18:24.603605 26738 http.cpp:997] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite' I0329 13:18:24.603682 26728 sched.cpp:336] New master detected at [email protected]:38742 I0329 13:18:24.603716 26728 sched.cpp:407] Authenticating with master [email protected]:38742 I0329 13:18:24.603729 26728 sched.cpp:414] Using default CRAM-MD5 authenticatee I0329 13:18:24.603817 26735 authenticatee.cpp:121] Creating new client SASL connection I0329 13:18:24.604050 26735 master.cpp:7252] Authenticating [email protected]:38742 I0329 13:18:24.604125 26733 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(645)@172.17.0.3:38742 I0329 13:18:24.604176 26738 slave.cpp:486] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0329 13:18:24.604207 26738 slave.cpp:494] Agent attributes: [ ] I0329 13:18:24.604212 26738 slave.cpp:499] Agent hostname: 2fe01027e182 I0329 13:18:24.604257 26733 status_update_manager.cpp:177] Pausing sending status updates I0329 13:18:24.604287 26742 authenticator.cpp:98] Creating new server SASL connection I0329 13:18:24.604569 26729 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0329 13:18:24.604598 26729 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0329 13:18:24.604635 26732 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_l4mHan/meta' I0329 13:18:24.604650 26746 authenticator.cpp:204] Received SASL authentication start I0329 13:18:24.604702 26746 authenticator.cpp:326] Authentication requires more steps I0329 13:18:24.604817 26733 status_update_manager.cpp:203] Recovering status update manager I0329 13:18:24.604842 26739 authenticatee.cpp:259] Received SASL authentication step I0329 13:18:24.604909 26735 authenticator.cpp:232] Received SASL authentication step I0329 13:18:24.604943 26735 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2fe01027e182' server FQDN: '2fe01027e182' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0329 13:18:24.604957 26735 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0329 13:18:24.604977 26735 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0329 13:18:24.604990 26735 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2fe01027e182' server FQDN: '2fe01027e182' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0329 13:18:24.604996 26735 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0329 13:18:24.605002 26735 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0329 13:18:24.605018 26735 authenticator.cpp:318] Authentication success I0329 13:18:24.605075 26740 authenticatee.cpp:299] Authentication success I0329 13:18:24.605258 26733 sched.cpp:513] Successfully authenticated with master [email protected]:38742 I0329 13:18:24.605275 26733 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:38742 I0329 13:18:24.605320 26733 sched.cpp:869] Will retry registration in 481.887127ms if necessary I0329 13:18:24.605334 26738 master.cpp:7282] Successfully authenticated principal 'test-principal' at [email protected]:38742 I0329 13:18:24.605388 26725 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(645)@172.17.0.3:38742 I0329 13:18:24.605401 26738 master.cpp:2817] Received SUBSCRIBE call for framework 'default' at [email protected]:38742 I0329 13:18:24.605413 26738 master.cpp:2201] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0329 13:18:24.605430 26730 slave.cpp:5921] Finished recovery I0329 13:18:24.605590 26741 master.cpp:2894] Subscribing framework default with checkpointing disabled and capabilities [ ] I0329 13:18:24.605820 26730 slave.cpp:6103] Querying resource estimator for oversubscribable resources I0329 13:18:24.605881 26727 sched.cpp:759] Framework registered with be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.605911 26727 sched.cpp:773] Scheduler::registered took 17127ns I0329 13:18:24.605921 26739 hierarchical.cpp:271] Added framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.605999 26730 slave.cpp:876] New master detected at [email protected]:38742 I0329 13:18:24.606011 26728 status_update_manager.cpp:177] Pausing sending status updates I0329 13:18:24.606029 26739 hierarchical.cpp:1862] No allocations performed I0329 13:18:24.606040 26739 hierarchical.cpp:1952] No inverse offers to send out! I0329 13:18:24.606039 26730 slave.cpp:911] Detecting new master I0329 13:18:24.606055 26739 hierarchical.cpp:1446] Performed allocation for 0 agents in 37912ns I0329 13:18:24.606189 26730 slave.cpp:6117] Received oversubscribable resources {} from the resource estimator I0329 13:18:24.614189 26741 slave.cpp:938] Authenticating with master [email protected]:38742 I0329 13:18:24.614224 26741 slave.cpp:949] Using default CRAM-MD5 authenticatee I0329 13:18:24.614388 26744 authenticatee.cpp:121] Creating new client SASL connection I0329 13:18:24.614562 26733 master.cpp:7252] Authenticating slave(296)@172.17.0.3:38742 I0329 13:18:24.614625 26741 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(646)@172.17.0.3:38742 I0329 13:18:24.614714 26735 authenticator.cpp:98] Creating new server SASL connection I0329 13:18:24.614948 26736 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0329 13:18:24.614972 26736 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0329 13:18:24.615044 26737 authenticator.cpp:204] Received SASL authentication start I0329 13:18:24.615099 26737 authenticator.cpp:326] Authentication requires more steps I0329 13:18:24.615149 26737 authenticatee.cpp:259] Received SASL authentication step I0329 13:18:24.615213 26724 authenticator.cpp:232] Received SASL authentication step I0329 13:18:24.615242 26724 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2fe01027e182' server FQDN: '2fe01027e182' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0329 13:18:24.615252 26724 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0329 13:18:24.615262 26724 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0329 13:18:24.615269 26724 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2fe01027e182' server FQDN: '2fe01027e182' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0329 13:18:24.615274 26724 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0329 13:18:24.615278 26724 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0329 13:18:24.615288 26724 authenticator.cpp:318] Authentication success I0329 13:18:24.615331 26737 authenticatee.cpp:299] Authentication success I0329 13:18:24.615342 26724 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(646)@172.17.0.3:38742 I0329 13:18:24.615365 26735 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(296)@172.17.0.3:38742 I0329 13:18:24.615411 26737 slave.cpp:1033] Successfully authenticated with master [email protected]:38742 I0329 13:18:24.615483 26737 slave.cpp:1461] Will retry registration in 18.734777ms if necessary I0329 13:18:24.615546 26741 master.cpp:5437] Registering agent at slave(296)@172.17.0.3:38742 (2fe01027e182) with id be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 I0329 13:18:24.615713 26747 registrar.cpp:463] Applied 1 operations in 35952ns; attempting to update the registry I0329 13:18:24.616206 26747 registrar.cpp:508] Successfully updated the registry in 450048ns I0329 13:18:24.616482 26741 slave.cpp:4703] Received ping from slave-observer(290)@172.17.0.3:38742 I0329 13:18:24.616587 26741 slave.cpp:1079] Registered with master [email protected]:38742; given agent ID be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 I0329 13:18:24.616606 26741 fetcher.cpp:94] Clearing fetcher cache I0329 13:18:24.616569 26742 master.cpp:5511] Registered agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0329 13:18:24.616636 26734 hierarchical.cpp:527] Added agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 (2fe01027e182) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0329 13:18:24.616729 26727 status_update_manager.cpp:184] Resuming sending status updates I0329 13:18:24.616930 26741 slave.cpp:1107] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_l4mHan/meta/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/slave.info' I0329 13:18:24.616956 26734 hierarchical.cpp:1952] No inverse offers to send out! I0329 13:18:24.616972 26734 hierarchical.cpp:1446] Performed allocation for 1 agents in 271084ns I0329 13:18:24.617112 26728 master.cpp:7081] Sending 1 offers to framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 (default) at [email protected]:38742 I0329 13:18:24.617172 26741 slave.cpp:1145] Forwarding total oversubscribed resources {} I0329 13:18:24.617274 26736 master.cpp:6098] Received update of agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) with total oversubscribed resources {} I0329 13:18:24.617390 26731 sched.cpp:933] Scheduler::resourceOffers took 135306ns I0329 13:18:24.618221 26740 master.cpp:3839] Processing ACCEPT call for offers: [ be7284e7-ed26-4163-aafa-532c0c06a1e5-O0 ] on agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 (default) at [email protected]:38742 I0329 13:18:24.618257 26740 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 1 I0329 13:18:24.618320 26740 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task 2 W0329 13:18:24.618736 26740 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. W0329 13:18:24.618754 26740 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. I0329 13:18:24.618816 26740 master.cpp:9097] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.618855 26740 master.cpp:4489] Launching task 1 of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 (default) at [email protected]:38742 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.619007 26730 slave.cpp:1571] Got assigned task '1' for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 W0329 13:18:24.619112 26740 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. W0329 13:18:24.619127 26740 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. I0329 13:18:24.619181 26740 master.cpp:9097] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.619217 26740 master.cpp:4489] Launching task 2 of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 (default) at [email protected]:38742 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 at slave(296)@172.17.0.3:38742 (2fe01027e182) I0329 13:18:24.619226 26730 slave.cpp:1852] Authorizing task '1' for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.619256 26730 slave.cpp:6540] Authorizing framework principal 'test-principal' to launch task 1 I0329 13:18:24.619462 26730 slave.cpp:1571] Got assigned task '2' for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.619722 26730 slave.cpp:2039] Launching task '1' for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.619786 26724 hierarchical.cpp:852] Updated allocation of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 on agent be7284e7-ed26-4163-aafa-532c0c06a1e5-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] I0329 13:18:24.619927 26724 hierarchical.cpp:1116] 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 be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 from framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.619952 26724 hierarchical.cpp:1153] Framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 filtered agent be7284e7-ed26-4163-aafa-532c0c06a1e5-S0 for 5secs I0329 13:18:24.620236 26730 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_l4mHan/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/frameworks/be7284e7-ed26-4163-aafa-532c0c06a1e5-0000/executors/executor-1/runs/e7e920d5-190d-4745-9574-15256e36bfae' to user 'mesos' I0329 13:18:24.620390 26730 slave.cpp:6884] Launching executor 'executor-1' of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_l4mHan/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/frameworks/be7284e7-ed26-4163-aafa-532c0c06a1e5-0000/executors/executor-1/runs/e7e920d5-190d-4745-9574-15256e36bfae' I0329 13:18:24.620625 26730 slave.cpp:2268] Queued task '1' for executor 'executor-1' of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.620669 26730 slave.cpp:1852] Authorizing task '2' for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.620688 26730 slave.cpp:6540] Authorizing framework principal 'test-principal' to launch task 2 I0329 13:18:24.620831 26730 slave.cpp:829] Successfully attached file '/tmp/MasterTest_MultipleExecutors_l4mHan/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/frameworks/be7284e7-ed26-4163-aafa-532c0c06a1e5-0000/executors/executor-1/runs/e7e920d5-190d-4745-9574-15256e36bfae' I0329 13:18:24.621069 26730 slave.cpp:2039] Launching task '2' for framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.621345 26730 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_l4mHan/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/frameworks/be7284e7-ed26-4163-aafa-532c0c06a1e5-0000/executors/executor-2/runs/9d765aec-265c-44a4-9d8a-5ca3d5ed8b76' to user 'mesos' I0329 13:18:24.621479 26730 slave.cpp:6884] Launching executor 'executor-2' of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_l4mHan/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/frameworks/be7284e7-ed26-4163-aafa-532c0c06a1e5-0000/executors/executor-2/runs/9d765aec-265c-44a4-9d8a-5ca3d5ed8b76' I0329 13:18:24.621701 26730 slave.cpp:2268] Queued task '2' for executor 'executor-2' of framework be7284e7-ed26-4163-aafa-532c0c06a1e5-0000 I0329 13:18:24.621737 26730 slave.cpp:829] Successfully attached file '/tmp/MasterTest_MultipleExecutors_l4mHan/slaves/be7284e7-ed26-4163-aafa-532c0c06a1e5-S0/frameworks/be7284e7-ed26-4163-aafa-532c0c06a1e5-0000/executors/executor-2/runs/9d765aec-265c-44a4-9d8a-5ca3d5ed8b76' *** Aborted at 1490793504 (unix time) try "date -d @1490793504" if you are using GNU date *** I0329 13:18:24.621949 26741 exec.cpp:162] Version: 1.3.0 I0329 13:18:24.622002 26731 exec.cpp:212] Executor started at: executor(121)@172.17.0.3:38742 with pid 26723 PC: @ 0x2b0f1acc282d (unknown) *** SIGSEGV (@0xe0) received by PID 26723 (TID 0x2b0f22855700) from PID 224; stack trace: *** @ 0x2b0f1a259330 (unknown) @ 0x2b0f1acc282d (unknown) @ 0x2b0f156a4605 mesos::internal::slave::executorEnvironment() @ 0x2b0f1569f7c4 mesos::internal::slave::Slave::launchExecutor() @ 0x2b0f16fbf7d7 process::ProcessManager::resume() @ 0x2b0f16fd555f std::thread::_Impl<>::_M_run() @ 0x2b0f1a518a60 (unknown) @ 0x2b0f1a251184 start_thread @ 0x2b0f1ad84bed (unknown) make[3]: *** [CMakeFiles/check] Segmentation fault (core dumped) make[3]: Leaving directory `/mesos/build' make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[2]: Leaving directory `/mesos/build' make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make[1]: Leaving directory `/mesos/build' make: *** [check] Error 2 + docker rmi mesos-1490791529-132 Untagged: mesos-1490791529-132:latest Deleted: sha256:bf196beb80ef10718bd74c6e05161168fb64db017fb29e416699198ce92fc05b Deleted: sha256:0d2aea0563308aa7aea8b4c9ea2350427d7a2d515b678b9f1ea36a4eac866f8e Deleted: sha256:48540c787f9e40c7803427200debd80bf209f75f228ea0ba7264d490cccf19ce Deleted: sha256:6b4ebfde285dd28b1391a026372cd592fadb2e79537ea2b3eeaf6aadf33fc6c8 Deleted: sha256:6b62ffa14ada01dfd6abbf8da315041d7756415b60ef89123ab885903ef5f5b4 Deleted: sha256:f10c7c62f497a9775294637b1a15ccb5a4a4e7b9b1bd63d03ffc9f36306b398c Deleted: sha256:e461c68b0c602677b1453e5b627cd139f5996d537c5dafbd64b1b6bccb316563 Deleted: sha256:b842d4b931baf02e6c24d085f4f82b5414aa8546317b145a578dcf67511d0967 Deleted: sha256:8560f1d3ffd506494a59df18958d518969c1a5e351625c8ca7e8448b2e034407 Deleted: sha256:fcfd5d7c5301d6825e52e90a356263b392ed71c25205239ae5506ce694f6a87d Deleted: sha256:9ae4264ff96cc1acdfc71f0bf1cffa51c3ed5cbb956adb2dc5c46daa6de5c71f Deleted: sha256:b744932e2c803391280231fdb2351eb7f5e12da4d922d1b9ad64b6a6678cae65 Deleted: sha256:4af8a820b3e7127ca8babac4cd3966f96b09bcb806b5d1c62c748e68a9dd2b6c Deleted: sha256:8458bbe1154084596602c8adec50ad3d439a9eeaa1d53950ca71348a107a6ae7 Deleted: sha256:4d2689e2b48d52b95805fd040d2946f4dcebb20733381892504a0c3eca1dd86f Deleted: sha256:7ffe106f90721115bc5201ae78317aa9596e5045a3074242ce2bea788b1772d2 Deleted: sha256:9dd525fcf4478b9fc9a0091f74da92c65eda873ef09991f7254aad2e5e10ce30 Deleted: sha256:9cf60aa935c1ba189e95df07a3f5c5acdec5cc09a68de9793f247edc3f9d71a2 Deleted: sha256:5adb839b78330b22a3a280ef326f5f86818399d78b866a0bd9beff6f2df4779b Deleted: sha256:7f1baf7778fd9da4d7c86e6de02b7be95046202f8c4d770e886091b4204c751e Deleted: sha256:080b05635620f5c89924dc89cac930b6bb4db2918a23583b06ab26933b27d469 Deleted: sha256:19b67160f660162080d2d730866a2fbd9e30a0248baf5fc1d5ec43b73b893bf2 Deleted: sha256:332b2c62f6bffc92eeb5f2d64a22168a0eaea5c32eb869b8817809186930240e Deleted: sha256:699a0df09ac43589b7ee6dcdeb0a37d4d5adcdc457b621f1df2199bad2afe6f4 Build step 'Execute shell' marked build as failure
