See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,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)/3361/display/redirect?page=changes>
Changes: [klueska] Added ability to dynamically load '/dev/nvidia-uvm' in GPU isolator. ------------------------------------------ [...truncated 10.82 MB...] I0313 02:43:06.921901 30939 exec.cpp:405] Executor::frameworkMessage took 70936ns I0313 02:43:06.921912 30934 slave.cpp:3105] Status update manager successfully handled status update acknowledgement (UUID: 820c57e1-13ea-462d-9e52-d5ff1a802e10) for task 1 of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.922719 30930 slave.cpp:4324] Sending message for framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 to [email protected]:41735 I0313 02:43:06.922960 30936 sched.cpp:1177] Scheduler::frameworkMessage took 96833ns I0313 02:43:06.923434 30907 sched.cpp:2021] Asked to stop the driver I0313 02:43:06.923555 30933 sched.cpp:1203] Stopping framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.923804 30927 master.cpp:7705] Processing TEARDOWN call for framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 (default) at [email protected]:41735 I0313 02:43:06.923846 30927 master.cpp:7717] Removing framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 (default) at [email protected]:41735 I0313 02:43:06.923882 30927 master.cpp:3081] Deactivating framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 (default) at [email protected]:41735 I0313 02:43:06.924393 30937 hierarchical.cpp:415] Deactivated framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.924615 30927 master.cpp:8302] Updating the state of task 1 of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0313 02:43:06.924630 30934 slave.cpp:2658] Asked to shut down framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 by [email protected]:41735 I0313 02:43:06.924669 30934 slave.cpp:2683] Shutting down framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.924729 30934 slave.cpp:5075] Shutting down executor 'default' of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 at executor(74)@172.17.0.2:41735 I0313 02:43:06.925139 30930 exec.cpp:415] Executor asked to shutdown I0313 02:43:06.925284 30930 exec.cpp:430] Executor::shutdown took 128730ns I0313 02:43:06.925907 30933 slave.cpp:4388] Got exited event for executor(74)@172.17.0.2:41735 I0313 02:43:06.925845 30927 master.cpp:8396] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 on agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 at slave(179)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.926231 30927 master.cpp:8425] Removing executor 'default' with resources {} of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 on agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 at slave(179)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.926367 30937 hierarchical.cpp:1064] 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 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 from framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.926942 30934 hierarchical.cpp:362] Removed framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.927506 30926 slave.cpp:4761] Executor 'default' of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 exited with status 0 I0313 02:43:06.927639 30926 slave.cpp:4861] Cleaning up executor 'default' of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 at executor(74)@172.17.0.2:41735 W0313 02:43:06.927852 30937 master.cpp:6278] Ignoring unknown exited executor 'default' of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 on agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 at slave(179)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.927880 30933 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_G0N57U/slaves/10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0/frameworks/10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000/executors/default/runs/80dc8324-cd10-4d08-9b1b-7fe1ef2b25f4' for gc 6.99998926160889days in the future I0313 02:43:06.928058 30926 slave.cpp:4949] Cleaning up framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.928159 30933 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_G0N57U/slaves/10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0/frameworks/10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000/executors/default' for gc 6.99998925947852days in the future I0313 02:43:06.928205 30927 status_update_manager.cpp:285] Closing status update streams for framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.928259 30927 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000 I0313 02:43:06.928402 30933 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_G0N57U/slaves/10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0/frameworks/10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-0000' for gc 6.99998925680593days in the future I0313 02:43:06.928436 30929 slave.cpp:803] Agent terminating I0313 02:43:06.928709 30934 master.cpp:1264] Agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 at slave(179)@172.17.0.2:41735 (2b4bef4c704c) disconnected I0313 02:43:06.928746 30934 master.cpp:3118] Disconnecting agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 at slave(179)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.928843 30934 master.cpp:3137] Deactivating agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 at slave(179)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.929006 30932 hierarchical.cpp:618] Agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 deactivated I0313 02:43:06.931840 30907 master.cpp:1103] Master terminating I0313 02:43:06.932870 30940 hierarchical.cpp:549] Removed agent 10fa6a91-8af5-4f57-80ca-4f05aed8c2f5-S0 [ OK ] MasterTest.FrameworkMessage (80 ms) [ RUN ] MasterTest.MultipleExecutors I0313 02:43:06.940340 30907 cluster.cpp:160] Creating default 'local' authorizer I0313 02:43:06.943606 30925 master.cpp:383] Master 9c1cda56-374e-45ad-81e1-24f392c9caa4 (2b4bef4c704c) started on 172.17.0.2:41735 I0313 02:43:06.943648 30925 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/2Y3rI4/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.2.1/_inst/share/mesos/webui" --work_dir="/tmp/2Y3rI4/master" --zk_session_timeout="10secs" I0313 02:43:06.944038 30925 master.cpp:435] Master only allowing authenticated frameworks to register I0313 02:43:06.944054 30925 master.cpp:449] Master only allowing authenticated agents to register I0313 02:43:06.944062 30925 master.cpp:462] Master only allowing authenticated HTTP frameworks to register I0313 02:43:06.944075 30925 credentials.hpp:37] Loading credentials for authentication from '/tmp/2Y3rI4/credentials' I0313 02:43:06.944342 30925 master.cpp:507] Using default 'crammd5' authenticator I0313 02:43:06.944461 30925 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0313 02:43:06.944631 30925 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0313 02:43:06.944795 30925 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0313 02:43:06.944952 30925 master.cpp:587] Authorization enabled I0313 02:43:06.945243 30932 hierarchical.cpp:161] Initialized hierarchical allocator process I0313 02:43:06.945274 30930 whitelist_watcher.cpp:77] No whitelist given I0313 02:43:06.947253 30935 master.cpp:2124] Elected as the leading master! I0313 02:43:06.947289 30935 master.cpp:1646] Recovering from registrar I0313 02:43:06.947407 30925 registrar.cpp:329] Recovering registrar I0313 02:43:06.948166 30925 registrar.cpp:362] Successfully fetched the registry (0B) in 718080ns I0313 02:43:06.948257 30925 registrar.cpp:461] Applied 1 operations in 24847ns; attempting to update the registry I0313 02:43:06.949005 30925 registrar.cpp:506] Successfully updated the registry in 689920ns I0313 02:43:06.949147 30925 registrar.cpp:392] Successfully recovered registrar I0313 02:43:06.949889 30933 master.cpp:1762] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0313 02:43:06.949925 30931 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover I0313 02:43:06.954984 30907 cluster.cpp:446] Creating default 'local' authorizer I0313 02:43:06.956859 30934 slave.cpp:211] Mesos agent started on (180)@172.17.0.2:41735 I0313 02:43:06.956902 30934 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_k0QlN9/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_k0QlN9/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_k0QlN9/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.1/_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_k0QlN9" --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_RfqTfC" I0313 02:43:06.957628 30934 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_k0QlN9/credential' I0313 02:43:06.957857 30934 slave.cpp:354] Agent using credential for: test-principal I0313 02:43:06.957895 30934 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_k0QlN9/http_credentials' I0313 02:43:06.958219 30934 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0313 02:43:06.958361 30907 sched.cpp:232] Version: 1.2.1 I0313 02:43:06.958389 30934 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0313 02:43:06.959074 30930 sched.cpp:336] New master detected at [email protected]:41735 I0313 02:43:06.959177 30930 sched.cpp:407] Authenticating with master [email protected]:41735 I0313 02:43:06.959203 30930 sched.cpp:414] Using default CRAM-MD5 authenticatee I0313 02:43:06.959442 30932 authenticatee.cpp:121] Creating new client SASL connection I0313 02:43:06.959811 30928 master.cpp:7163] Authenticating [email protected]:41735 I0313 02:43:06.959928 30931 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(412)@172.17.0.2:41735 I0313 02:43:06.960317 30936 authenticator.cpp:98] Creating new server SASL connection I0313 02:43:06.960286 30934 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0313 02:43:06.960389 30934 slave.cpp:549] Agent attributes: [ ] I0313 02:43:06.960407 30934 slave.cpp:554] Agent hostname: 2b4bef4c704c I0313 02:43:06.960562 30939 status_update_manager.cpp:177] Pausing sending status updates I0313 02:43:06.960629 30938 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0313 02:43:06.960676 30938 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0313 02:43:06.960808 30938 authenticator.cpp:204] Received SASL authentication start I0313 02:43:06.960886 30938 authenticator.cpp:326] Authentication requires more steps I0313 02:43:06.961117 30930 authenticatee.cpp:259] Received SASL authentication step I0313 02:43:06.961261 30930 authenticator.cpp:232] Received SASL authentication step I0313 02:43:06.961299 30930 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2b4bef4c704c' server FQDN: '2b4bef4c704c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0313 02:43:06.961895 30932 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_RfqTfC/meta' I0313 02:43:06.961971 30930 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0313 02:43:06.962031 30930 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0313 02:43:06.962107 30930 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2b4bef4c704c' server FQDN: '2b4bef4c704c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0313 02:43:06.962141 30930 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0313 02:43:06.962162 30930 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0313 02:43:06.962187 30930 authenticator.cpp:318] Authentication success I0313 02:43:06.962399 30925 authenticatee.cpp:299] Authentication success I0313 02:43:06.962463 30931 master.cpp:7193] Successfully authenticated principal 'test-principal' at [email protected]:41735 I0313 02:43:06.962697 30929 status_update_manager.cpp:203] Recovering status update manager I0313 02:43:06.962766 30926 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(412)@172.17.0.2:41735 I0313 02:43:06.962996 30928 sched.cpp:513] Successfully authenticated with master [email protected]:41735 I0313 02:43:06.963029 30928 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:41735 I0313 02:43:06.963284 30928 sched.cpp:869] Will retry registration in 1.497230116secs if necessary I0313 02:43:06.963302 30927 slave.cpp:5550] Finished recovery I0313 02:43:06.963418 30929 master.cpp:2737] Received SUBSCRIBE call for framework 'default' at [email protected]:41735 I0313 02:43:06.963456 30929 master.cpp:2160] Authorizing framework principal 'test-principal' to receive offers for role '*' I0313 02:43:06.963829 30927 slave.cpp:5724] Querying resource estimator for oversubscribable resources I0313 02:43:06.964030 30934 master.cpp:2813] Subscribing framework default with checkpointing disabled and capabilities [ ] I0313 02:43:06.964058 30927 slave.cpp:5738] Received oversubscribable resources {} from the resource estimator I0313 02:43:06.964452 30932 status_update_manager.cpp:177] Pausing sending status updates I0313 02:43:06.964453 30927 slave.cpp:931] New master detected at [email protected]:41735 I0313 02:43:06.964632 30927 slave.cpp:966] Detecting new master I0313 02:43:06.964814 30926 hierarchical.cpp:286] Added framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.964895 30932 sched.cpp:759] Framework registered with 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.964957 30932 sched.cpp:773] Scheduler::registered took 37427ns I0313 02:43:06.964963 30926 hierarchical.cpp:1810] No allocations performed I0313 02:43:06.965023 30926 hierarchical.cpp:1900] No inverse offers to send out! I0313 02:43:06.965085 30926 hierarchical.cpp:1394] Performed allocation for 0 agents in 182019ns I0313 02:43:06.970898 30935 slave.cpp:993] Authenticating with master [email protected]:41735 I0313 02:43:06.970984 30935 slave.cpp:1004] Using default CRAM-MD5 authenticatee I0313 02:43:06.971241 30930 authenticatee.cpp:121] Creating new client SASL connection I0313 02:43:06.971518 30931 master.cpp:7163] Authenticating slave(180)@172.17.0.2:41735 I0313 02:43:06.971634 30928 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(413)@172.17.0.2:41735 I0313 02:43:06.971889 30930 authenticator.cpp:98] Creating new server SASL connection I0313 02:43:06.972179 30932 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0313 02:43:06.972234 30932 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0313 02:43:06.972353 30932 authenticator.cpp:204] Received SASL authentication start I0313 02:43:06.972424 30932 authenticator.cpp:326] Authentication requires more steps I0313 02:43:06.972554 30929 authenticatee.cpp:259] Received SASL authentication step I0313 02:43:06.972719 30936 authenticator.cpp:232] Received SASL authentication step I0313 02:43:06.972765 30936 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2b4bef4c704c' server FQDN: '2b4bef4c704c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0313 02:43:06.972784 30936 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0313 02:43:06.972823 30936 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0313 02:43:06.972898 30936 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2b4bef4c704c' server FQDN: '2b4bef4c704c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0313 02:43:06.972929 30936 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0313 02:43:06.972944 30936 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0313 02:43:06.972968 30936 authenticator.cpp:318] Authentication success I0313 02:43:06.973120 30926 authenticatee.cpp:299] Authentication success I0313 02:43:06.973171 30925 master.cpp:7193] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.2:41735 I0313 02:43:06.973350 30935 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(413)@172.17.0.2:41735 I0313 02:43:06.973618 30934 slave.cpp:1088] Successfully authenticated with master [email protected]:41735 I0313 02:43:06.973810 30934 slave.cpp:1515] Will retry registration in 8.867649ms if necessary I0313 02:43:06.974061 30930 master.cpp:5378] Registering agent at slave(180)@172.17.0.2:41735 (2b4bef4c704c) with id 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 I0313 02:43:06.974465 30926 registrar.cpp:461] Applied 1 operations in 71929ns; attempting to update the registry I0313 02:43:06.976281 30926 registrar.cpp:506] Successfully updated the registry in 1.740032ms I0313 02:43:06.977159 30939 slave.cpp:4346] Received ping from slave-observer(177)@172.17.0.2:41735 I0313 02:43:06.977238 30929 master.cpp:5452] Registered agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0313 02:43:06.977653 30930 hierarchical.cpp:516] Added agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 (2b4bef4c704c) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0313 02:43:06.979151 30939 slave.cpp:1134] Registered with master [email protected]:41735; given agent ID 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 I0313 02:43:06.979185 30939 fetcher.cpp:94] Clearing fetcher cache I0313 02:43:06.979245 30930 hierarchical.cpp:1900] No inverse offers to send out! I0313 02:43:06.979362 30930 hierarchical.cpp:1394] Performed allocation for 1 agents in 1.559855ms I0313 02:43:06.979404 30925 status_update_manager.cpp:184] Resuming sending status updates I0313 02:43:06.979709 30939 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_RfqTfC/meta/slaves/9c1cda56-374e-45ad-81e1-24f392c9caa4-S0/slave.info' I0313 02:43:06.979838 30928 master.cpp:6992] Sending 1 offers to framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 (default) at [email protected]:41735 I0313 02:43:06.980218 30939 slave.cpp:1200] Forwarding total oversubscribed resources {} I0313 02:43:06.980398 30939 master.cpp:6009] Received update of agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) with total oversubscribed resources {} I0313 02:43:06.980480 30940 sched.cpp:933] Scheduler::resourceOffers took 221735ns I0313 02:43:06.980859 30938 hierarchical.cpp:589] Agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 (2b4bef4c704c) updated with oversubscribed resources {} (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000]) I0313 02:43:06.981079 30938 hierarchical.cpp:1810] No allocations performed I0313 02:43:06.981127 30938 hierarchical.cpp:1900] No inverse offers to send out! I0313 02:43:06.981176 30938 hierarchical.cpp:1394] Performed allocation for 1 agents in 196769ns I0313 02:43:06.983216 30937 master.cpp:3776] Processing ACCEPT call for offers: [ 9c1cda56-374e-45ad-81e1-24f392c9caa4-O0 ] on agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) for framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 (default) at [email protected]:41735 I0313 02:43:06.983347 30937 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 1 I0313 02:43:06.983680 30937 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 2 W0313 02:43:06.986129 30937 validation.cpp:1064] 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 02:43:06.986169 30937 validation.cpp:1076] 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 02:43:06.986560 30937 master.cpp:9053] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.986716 30937 master.cpp:4426] Launching task 1 of framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 (default) at [email protected]:41735 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.987198 30940 slave.cpp:1625] Got assigned task '1' for framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.987824 30940 slave.cpp:1785] Launching task '1' for framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 W0313 02:43:06.987949 30937 validation.cpp:1064] 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 02:43:06.988003 30937 validation.cpp:1076] 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 02:43:06.988368 30937 master.cpp:9053] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.988461 30940 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_RfqTfC/slaves/9c1cda56-374e-45ad-81e1-24f392c9caa4-S0/frameworks/9c1cda56-374e-45ad-81e1-24f392c9caa4-0000/executors/executor-1/runs/b9a23437-09bf-426d-ba0f-e111f2167425' to user 'mesos' I0313 02:43:06.988508 30937 master.cpp:4426] Launching task 2 of framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 (default) at [email protected]:41735 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 at slave(180)@172.17.0.2:41735 (2b4bef4c704c) I0313 02:43:06.988695 30940 slave.cpp:6472] Launching executor 'executor-1' of framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_RfqTfC/slaves/9c1cda56-374e-45ad-81e1-24f392c9caa4-S0/frameworks/9c1cda56-374e-45ad-81e1-24f392c9caa4-0000/executors/executor-1/runs/b9a23437-09bf-426d-ba0f-e111f2167425' I0313 02:43:06.989156 30940 slave.cpp:2118] Queued task '1' for executor 'executor-1' of framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.989338 30940 slave.cpp:1625] Got assigned task '2' for framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.989728 30940 slave.cpp:884] Successfully attached file '/tmp/MasterTest_MultipleExecutors_RfqTfC/slaves/9c1cda56-374e-45ad-81e1-24f392c9caa4-S0/frameworks/9c1cda56-374e-45ad-81e1-24f392c9caa4-0000/executors/executor-1/runs/b9a23437-09bf-426d-ba0f-e111f2167425' I0313 02:43:06.989796 30940 slave.cpp:1785] Launching task '2' for framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.990180 30940 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_RfqTfC/slaves/9c1cda56-374e-45ad-81e1-24f392c9caa4-S0/frameworks/9c1cda56-374e-45ad-81e1-24f392c9caa4-0000/executors/executor-2/runs/c9b6f571-eeb5-4ff1-9048-d8ed22ca49b5' to user 'mesos' I0313 02:43:06.990356 30940 slave.cpp:6472] Launching executor 'executor-2' of framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_RfqTfC/slaves/9c1cda56-374e-45ad-81e1-24f392c9caa4-S0/frameworks/9c1cda56-374e-45ad-81e1-24f392c9caa4-0000/executors/executor-2/runs/c9b6f571-eeb5-4ff1-9048-d8ed22ca49b5' *** Aborted at 1489372986 (unix time) try "date -d @1489372986" if you are using GNU date *** PC: @ 0x2ac77510182d (unknown) I0313 02:43:06.990887 30937 exec.cpp:162] Version: 1.2.1 *** SIGSEGV (@0xf0) received by PID 30907 (TID 0x2ac77fbf4700) from PID 240; stack trace: *** I0313 02:43:06.991041 30930 hierarchical.cpp:807] Updated allocation of framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 on agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-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 02:43:06.991199 30939 exec.cpp:212] Executor started at: executor(75)@172.17.0.2:41735 with pid 30907 I0313 02:43:06.991724 30930 hierarchical.cpp:1064] 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 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 from framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 I0313 02:43:06.991793 30930 hierarchical.cpp:1101] Framework 9c1cda56-374e-45ad-81e1-24f392c9caa4-0000 filtered agent 9c1cda56-374e-45ad-81e1-24f392c9caa4-S0 for 5secs @ 0x2ac786dea2d7 (unknown) @ 0x2ac786dee5b9 (unknown) @ 0x2ac774eb8330 (unknown) @ 0x2ac77510182d (unknown) @ 0x2ac76acd8088 os::getenv() @ 0x2ac7714242ff mesos::internal::slave::executorEnvironment() @ 0x2ac7714014bd mesos::internal::slave::Framework::launchExecutor() @ 0x2ac7713fe534 mesos::internal::slave::Slave::_run() @ 0x2ac77149cb00 _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_ @ 0x2ac77149c5af _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_ @ 0x2ac7725c66b4 std::function<>::operator()() @ 0x2ac7725adca4 process::ProcessBase::visit() @ 0x2ac772623f1e process::DispatchEvent::visit() @ 0x2ac76acbdb21 process::ProcessBase::serve() @ 0x2ac7725ab737 process::ProcessManager::resume() @ 0x2ac7725b9afc process::ProcessManager::init_threads()::$_2::operator()() @ 0x2ac7725b9a05 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_2vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE @ 0x2ac7725b99d5 std::_Bind_simple<>::operator()() @ 0x2ac7725b99ac std::thread::_Impl<>::_M_run() @ 0x2ac774739a60 (unknown) @ 0x2ac774eb0184 start_thread @ 0x2ac7751c037d (unknown) make[4]: *** [check-local] Segmentation fault make[4]: Leaving directory `/mesos/mesos-1.2.1/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.2.1/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.2.1/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.2.1/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1489370562-29780 Untagged: mesos-1489370562-29780:latest Deleted: sha256:0f46400c6f1c0829bcd6e46b337d52f7ddb3d48d6be77cbe978ddd4af302a195 Deleted: sha256:fe8d77bbad223d8c62717b89dab0eb5eca55c8d3d5635a61949cf10c5c172ad4 Deleted: sha256:b255444278bd0924d3bd5579921d979f41c075c921b9f498f43b7e948e89b04d Deleted: sha256:4549f47869cb920f5ea6c4ad39c44ec497757946ee7e5338b0647e59a5db4a33 Deleted: sha256:f9b20892204bdaa4875fcba510a06345186881c53d464fbcc38d21d4b5dbf88a Deleted: sha256:52813e3c8cf973326bb77b073f96c68678594a1b63aed56962bbf284ea334fce Deleted: sha256:850d653734396cb56a12769fecd0493ecf0ac6c2d4237e27b2d4ad319b4acdbd Deleted: sha256:8276956c7e037ec69027b7b6fcae003f42deea356434d7d8b0fa05884ca84ca8 Deleted: sha256:ba12143a92ce1ffbc5aa69fbb29a44eb4bf41b63b213dfe96370b7b16c73c340 Deleted: sha256:8cc2c84cbbbd02e19d747511742788989d8e49f0a2436ba77b15962fdd68e802 Deleted: sha256:d81e7e2d3afb3bbc2c47948601be5f59f384da0228a24e1e375be20e96762847 Deleted: sha256:8e956c2f1aa93acf11fb5cc5c94cb52d48f6a3f8a8be8750d559ca5a5e99ffd5 Deleted: sha256:57443600616be95f36e4dd2f013e24e7079ad41d063b46b58f6a3e7cb7168952 Deleted: sha256:804a40b20194e5244393f041e2151757e08730fdfea4e6ed89dbffbf539ed27e Deleted: sha256:c56d236ed3cd8505beefc6cf02a0a8ee233221c8e403151219dac94f218b473a Deleted: sha256:3a57643071e3c2244a6545a3aeb88da9ad27a2f59f625d097c7e91f82054e545 Deleted: sha256:3d450c67d78120eeebd131f19bb0d57f2d536f7ebc1ba642cef7bf811c7cb942 Deleted: sha256:2fb593a675728ddd0cef464de413755503379da1b7d681bbac84d3a49741dbc2 Deleted: sha256:838675507beaaec33fbb484001d13ae9323aee49341040fc2137ab5529f17ba8 Deleted: sha256:47f48266480394c9e210a3a130d6910ce8e55e94f6b95faa23927fcfbb200b02 Deleted: sha256:8ae700efc6454ab8f66df848babd1b546b6dd71a06a1075b4cff08bd6a326da9 Deleted: sha256:233850ca53b1b90a827cb64b890eef3a75bcc457334fc99c61f5ba9ad51872c5 Deleted: sha256:32ca46d6b32a627e2858238257ae09af7275c782eab10ff77f0f7ae3263a3f2b Deleted: sha256:3cb0e65f1923f5e0128cdefb0a6090f75962ca077cb9dccebf29206062905cbb Build step 'Execute shell' marked build as failure
