See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=autotools,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3481/display/redirect?page=changes>
Changes: [vinodkone] Updated 'HealthChecker' to authenticate with the agent. [vinodkone] Updated 'Checker' to authenticate with agent operator API. [vinodkone] Updated default executor to pass authorization header to checkers. [vinodkone] Updated a health checker test to enable executor authentication. [vinodkone] Updated check tests to authenticate with agent operator API. ------------------------------------------ [...truncated 10.89 MB...] I0414 00:42:43.949404 30678 slave.cpp:3492] Status update manager successfully handled status update acknowledgement (UUID: 9fcb71a9-5c9d-48e8-8df8-68d14beb46ab) for task 1 of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.949534 30677 exec.cpp:405] Executor::frameworkMessage took 92181ns I0414 00:42:43.950320 30669 slave.cpp:4711] Sending message for framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 to [email protected]:40085 I0414 00:42:43.950570 30671 sched.cpp:1177] Scheduler::frameworkMessage took 68963ns I0414 00:42:43.951011 30649 sched.cpp:2021] Asked to stop the driver I0414 00:42:43.951128 30676 sched.cpp:1203] Stopping framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.951388 30674 master.cpp:7782] Processing TEARDOWN call for framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 (default) at [email protected]:40085 I0414 00:42:43.951437 30674 master.cpp:7794] Removing framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 (default) at [email protected]:40085 I0414 00:42:43.951475 30674 master.cpp:3165] Deactivating framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 (default) at [email protected]:40085 I0414 00:42:43.951757 30681 hierarchical.cpp:376] Deactivated framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.951814 30676 slave.cpp:3045] Asked to shut down framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 by [email protected]:40085 I0414 00:42:43.951836 30674 master.cpp:8362] Updating the state of task 1 of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0414 00:42:43.951903 30676 slave.cpp:3070] Shutting down framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.951969 30676 slave.cpp:5463] Shutting down executor 'default' of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 at executor(74)@172.17.0.3:40085 I0414 00:42:43.952244 30673 exec.cpp:415] Executor asked to shutdown I0414 00:42:43.952313 30673 exec.cpp:430] Executor::shutdown took 41339ns I0414 00:42:43.952541 30683 slave.cpp:4775] Got exited event for executor(74)@172.17.0.3:40085 I0414 00:42:43.953119 30674 master.cpp:8456] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 on agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 at slave(190)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:43.953740 30678 slave.cpp:5149] Executor 'default' of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 exited with status 0 I0414 00:42:43.953862 30674 master.cpp:8485] Removing executor 'default' with resources {} of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 on agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 at slave(190)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:43.953831 30678 slave.cpp:5249] Cleaning up executor 'default' of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 at executor(74)@172.17.0.3:40085 I0414 00:42:43.953959 30680 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 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 from framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.954780 30679 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_YaIXBf/slaves/44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0/frameworks/44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000/executors/default/runs/18b76365-f728-42bd-aeb8-cfb852ea0853' for gc 6.99998895219852days in the future I0414 00:42:43.954818 30678 slave.cpp:5337] Cleaning up framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 W0414 00:42:43.954823 30674 master.cpp:6384] Ignoring unknown exited executor 'default' of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 on agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 at slave(190)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:43.954949 30670 status_update_manager.cpp:285] Closing status update streams for framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.954949 30675 hierarchical.cpp:323] Removed framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.955018 30670 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000 I0414 00:42:43.955142 30678 slave.cpp:778] Agent terminating I0414 00:42:43.955185 30679 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_YaIXBf/slaves/44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0/frameworks/44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000/executors/default' for gc 6.99998894961778days in the future I0414 00:42:43.955328 30679 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_YaIXBf/slaves/44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0/frameworks/44896ad7-c180-40dd-9b1b-2bb9e96d0d04-0000' for gc 6.99998894707259days in the future I0414 00:42:43.955395 30668 master.cpp:1318] Agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 at slave(190)@172.17.0.3:40085 (3d2e1f13f513) disconnected I0414 00:42:43.955456 30668 master.cpp:3202] Disconnecting agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 at slave(190)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:43.955571 30668 master.cpp:3221] Deactivating agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 at slave(190)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:43.955793 30673 hierarchical.cpp:655] Agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 deactivated I0414 00:42:43.960222 30671 master.cpp:1157] Master terminating I0414 00:42:43.960930 30670 hierarchical.cpp:560] Removed agent 44896ad7-c180-40dd-9b1b-2bb9e96d0d04-S0 [ OK ] MasterTest.FrameworkMessage (79 ms) [ RUN ] MasterTest.MultipleExecutors I0414 00:42:43.969064 30649 cluster.cpp:162] Creating default 'local' authorizer I0414 00:42:43.972254 30679 master.cpp:438] Master 63bbd5a3-0311-4824-b8bd-a5d4262020a1 (3d2e1f13f513) started on 172.17.0.3:40085 I0414 00:42:43.972357 30679 master.cpp:440] 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/qmzLU0/credentials" --framework_sorter="drf" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_framework_authenticators="basic" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0" --logging_level="INFO" --max_agent_ping_timeouts="5" --max_completed_frameworks="50" --max_completed_tasks_per_framework="1000" --max_unreachable_tasks_per_framework="1000" --port="5050" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --root_submissions="true" --user_sorter="drf" --version="false" --webui_dir="/mesos/mesos-1.3.0/_inst/share/mesos/webui" --work_dir="/tmp/qmzLU0/master" --zk_session_timeout="10secs" I0414 00:42:43.972695 30679 master.cpp:490] Master only allowing authenticated frameworks to register I0414 00:42:43.972712 30679 master.cpp:504] Master only allowing authenticated agents to register I0414 00:42:43.972723 30679 master.cpp:517] Master only allowing authenticated HTTP frameworks to register I0414 00:42:43.972735 30679 credentials.hpp:37] Loading credentials for authentication from '/tmp/qmzLU0/credentials' I0414 00:42:43.973063 30679 master.cpp:562] Using default 'crammd5' authenticator I0414 00:42:43.973224 30679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0414 00:42:43.973397 30679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0414 00:42:43.973588 30679 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0414 00:42:43.973767 30679 master.cpp:642] Authorization enabled I0414 00:42:43.973953 30669 hierarchical.cpp:159] Initialized hierarchical allocator process I0414 00:42:43.974005 30676 whitelist_watcher.cpp:77] No whitelist given I0414 00:42:43.976575 30668 master.cpp:2166] Elected as the leading master! I0414 00:42:43.976619 30668 master.cpp:1705] Recovering from registrar I0414 00:42:43.976745 30677 registrar.cpp:331] Recovering registrar I0414 00:42:43.977475 30677 registrar.cpp:364] Successfully fetched the registry (0B) in 681728ns I0414 00:42:43.977562 30677 registrar.cpp:463] Applied 1 operations in 15645ns; attempting to update the registry I0414 00:42:43.978418 30672 registrar.cpp:508] Successfully updated the registry in 784128ns I0414 00:42:43.978548 30672 registrar.cpp:394] Successfully recovered registrar I0414 00:42:43.979135 30673 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0414 00:42:43.979142 30675 master.cpp:1804] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0414 00:42:43.984298 30649 cluster.cpp:448] Creating default 'local' authorizer I0414 00:42:43.986179 30683 slave.cpp:225] Mesos agent started on (191)@172.17.0.3:40085 I0414 00:42:43.986212 30683 slave.cpp:226] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/MasterTest_MultipleExecutors_Y6OEQo/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_Y6OEQo/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_Y6OEQo/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" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MasterTest_MultipleExecutors_Y6OEQo" --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_35KHSH" I0414 00:42:43.986541 30683 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_Y6OEQo/credential' I0414 00:42:43.986680 30683 slave.cpp:258] Agent using credential for: test-principal I0414 00:42:43.986701 30683 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_Y6OEQo/http_credentials' I0414 00:42:43.986927 30683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0414 00:42:43.987095 30683 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0414 00:42:43.987277 30649 sched.cpp:232] Version: 1.3.0 I0414 00:42:43.987893 30675 sched.cpp:336] New master detected at [email protected]:40085 I0414 00:42:43.987990 30675 sched.cpp:407] Authenticating with master [email protected]:40085 I0414 00:42:43.988011 30675 sched.cpp:414] Using default CRAM-MD5 authenticatee I0414 00:42:43.988222 30669 authenticatee.cpp:121] Creating new client SASL connection I0414 00:42:43.988487 30681 master.cpp:7269] Authenticating [email protected]:40085 I0414 00:42:43.988582 30675 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(424)@172.17.0.3:40085 I0414 00:42:43.988812 30679 authenticator.cpp:98] Creating new server SASL connection I0414 00:42:43.988765 30683 slave.cpp:513] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0414 00:42:43.988884 30683 slave.cpp:521] Agent attributes: [ ] I0414 00:42:43.988909 30683 slave.cpp:526] Agent hostname: 3d2e1f13f513 I0414 00:42:43.989042 30673 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0414 00:42:43.989075 30673 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0414 00:42:43.989081 30677 status_update_manager.cpp:177] Pausing sending status updates I0414 00:42:43.989198 30670 authenticator.cpp:204] Received SASL authentication start I0414 00:42:43.989271 30670 authenticator.cpp:326] Authentication requires more steps I0414 00:42:43.989372 30673 authenticatee.cpp:259] Received SASL authentication step I0414 00:42:43.989483 30673 authenticator.cpp:232] Received SASL authentication step I0414 00:42:43.989517 30673 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3d2e1f13f513' server FQDN: '3d2e1f13f513' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0414 00:42:43.989534 30673 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0414 00:42:43.989567 30673 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0414 00:42:43.989591 30673 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3d2e1f13f513' server FQDN: '3d2e1f13f513' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0414 00:42:43.989606 30673 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0414 00:42:43.989617 30673 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0414 00:42:43.989634 30673 authenticator.cpp:318] Authentication success I0414 00:42:43.989751 30678 authenticatee.cpp:299] Authentication success I0414 00:42:43.989809 30668 master.cpp:7299] Successfully authenticated principal 'test-principal' at [email protected]:40085 I0414 00:42:43.989837 30673 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(424)@172.17.0.3:40085 I0414 00:42:43.990085 30671 sched.cpp:513] Successfully authenticated with master [email protected]:40085 I0414 00:42:43.990109 30671 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:40085 I0414 00:42:43.990228 30671 sched.cpp:869] Will retry registration in 1.777740244secs if necessary I0414 00:42:43.990363 30673 master.cpp:2818] Received SUBSCRIBE call for framework 'default' at [email protected]:40085 I0414 00:42:43.990442 30673 master.cpp:2202] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0414 00:42:43.990996 30682 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_35KHSH/meta' I0414 00:42:43.991021 30676 master.cpp:2895] Subscribing framework default with checkpointing disabled and capabilities [ ] I0414 00:42:43.991488 30671 status_update_manager.cpp:203] Recovering status update manager I0414 00:42:43.991801 30678 sched.cpp:759] Framework registered with 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:43.991852 30678 sched.cpp:773] Scheduler::registered took 20088ns I0414 00:42:43.991859 30672 hierarchical.cpp:271] Added framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:43.991899 30671 slave.cpp:5951] Finished recovery I0414 00:42:43.991968 30672 hierarchical.cpp:1862] No allocations performed I0414 00:42:43.992002 30672 hierarchical.cpp:1952] No inverse offers to send out! I0414 00:42:43.992041 30672 hierarchical.cpp:1446] Performed allocation for 0 agents in 108984ns I0414 00:42:43.992382 30671 slave.cpp:6133] Querying resource estimator for oversubscribable resources I0414 00:42:43.992777 30678 status_update_manager.cpp:177] Pausing sending status updates I0414 00:42:43.992796 30679 slave.cpp:906] New master detected at [email protected]:40085 I0414 00:42:43.992938 30679 slave.cpp:941] Detecting new master I0414 00:42:43.993124 30679 slave.cpp:6147] Received oversubscribable resources {} from the resource estimator I0414 00:42:43.994170 30672 slave.cpp:968] Authenticating with master [email protected]:40085 I0414 00:42:43.994225 30672 slave.cpp:979] Using default CRAM-MD5 authenticatee I0414 00:42:43.994410 30675 authenticatee.cpp:121] Creating new client SASL connection I0414 00:42:43.994715 30683 master.cpp:7269] Authenticating slave(191)@172.17.0.3:40085 I0414 00:42:43.994820 30677 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(425)@172.17.0.3:40085 I0414 00:42:43.995082 30669 authenticator.cpp:98] Creating new server SASL connection I0414 00:42:43.995302 30679 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0414 00:42:43.995338 30679 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0414 00:42:43.995496 30668 authenticator.cpp:204] Received SASL authentication start I0414 00:42:43.995566 30668 authenticator.cpp:326] Authentication requires more steps I0414 00:42:43.995743 30678 authenticatee.cpp:259] Received SASL authentication step I0414 00:42:43.995913 30673 authenticator.cpp:232] Received SASL authentication step I0414 00:42:43.995955 30673 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3d2e1f13f513' server FQDN: '3d2e1f13f513' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0414 00:42:43.995980 30673 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0414 00:42:43.996019 30673 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0414 00:42:43.996047 30673 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3d2e1f13f513' server FQDN: '3d2e1f13f513' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0414 00:42:43.996062 30673 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0414 00:42:43.996073 30673 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0414 00:42:43.996094 30673 authenticator.cpp:318] Authentication success I0414 00:42:43.996191 30679 authenticatee.cpp:299] Authentication success I0414 00:42:43.996251 30678 master.cpp:7299] Successfully authenticated principal 'test-principal' at slave(191)@172.17.0.3:40085 I0414 00:42:43.996331 30674 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(425)@172.17.0.3:40085 I0414 00:42:43.996630 30682 slave.cpp:1063] Successfully authenticated with master [email protected]:40085 I0414 00:42:43.996814 30682 slave.cpp:1491] Will retry registration in 8.643297ms if necessary I0414 00:42:43.997084 30678 master.cpp:5454] Registering agent at slave(191)@172.17.0.3:40085 (3d2e1f13f513) with id 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 I0414 00:42:43.997625 30669 registrar.cpp:463] Applied 1 operations in 67072ns; attempting to update the registry I0414 00:42:44.000124 30669 registrar.cpp:508] Successfully updated the registry in 2.399744ms I0414 00:42:44.001055 30680 slave.cpp:4733] Received ping from slave-observer(188)@172.17.0.3:40085 I0414 00:42:44.001588 30671 slave.cpp:1109] Registered with master [email protected]:40085; given agent ID 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 I0414 00:42:44.001504 30670 master.cpp:5528] Registered agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0414 00:42:44.001621 30671 fetcher.cpp:94] Clearing fetcher cache I0414 00:42:44.001771 30680 hierarchical.cpp:527] Added agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 (3d2e1f13f513) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0414 00:42:44.001893 30678 status_update_manager.cpp:184] Resuming sending status updates I0414 00:42:44.002111 30671 slave.cpp:1137] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_35KHSH/meta/slaves/63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0/slave.info' I0414 00:42:44.002609 30671 slave.cpp:1175] Forwarding total oversubscribed resources {} I0414 00:42:44.002791 30681 master.cpp:6115] Received update of agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) with total oversubscribed resources {} I0414 00:42:44.003252 30680 hierarchical.cpp:1952] No inverse offers to send out! I0414 00:42:44.003312 30680 hierarchical.cpp:1446] Performed allocation for 1 agents in 1.408656ms I0414 00:42:44.003872 30671 master.cpp:7098] Sending 1 offers to framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 (default) at [email protected]:40085 I0414 00:42:44.004431 30668 sched.cpp:933] Scheduler::resourceOffers took 138312ns I0414 00:42:44.007447 30668 master.cpp:3856] Processing ACCEPT call for offers: [ 63bbd5a3-0311-4824-b8bd-a5d4262020a1-O0 ] on agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 (default) at [email protected]:40085 I0414 00:42:44.007586 30668 master.cpp:3432] Authorizing framework principal 'test-principal' to launch task 1 I0414 00:42:44.007870 30668 master.cpp:3432] Authorizing framework principal 'test-principal' to launch task 2 W0414 00:42:44.010324 30672 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. W0414 00:42:44.010363 30672 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. I0414 00:42:44.010782 30672 master.cpp:9114] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:44.011004 30672 master.cpp:4506] Launching task 1 of framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 (default) at [email protected]:40085 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:44.011484 30674 slave.cpp:1601] Got assigned task '1' for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.012264 30674 slave.cpp:1882] Authorizing task '1' for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.012344 30674 slave.cpp:6570] Authorizing framework principal 'test-principal' to launch task 1 W0414 00:42:44.012365 30672 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. W0414 00:42:44.012401 30672 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. I0414 00:42:44.012858 30672 master.cpp:9114] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:44.013137 30672 master.cpp:4506] Launching task 2 of framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 (default) at [email protected]:40085 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 at slave(191)@172.17.0.3:40085 (3d2e1f13f513) I0414 00:42:44.013507 30680 slave.cpp:2069] Launching task '1' for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.014051 30680 paths.cpp:554] Trying to chown '/tmp/MasterTest_MultipleExecutors_35KHSH/slaves/63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0/frameworks/63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000/executors/executor-1/runs/ecab473e-e790-4d14-b24c-c3684a8733e0' to user 'mesos' I0414 00:42:44.014353 30680 slave.cpp:6914] Launching executor 'executor-1' of framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_35KHSH/slaves/63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0/frameworks/63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000/executors/executor-1/runs/ecab473e-e790-4d14-b24c-c3684a8733e0' I0414 00:42:44.015077 30680 slave.cpp:2298] Queued task '1' for executor 'executor-1' of framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.015338 30680 slave.cpp:1601] Got assigned task '2' for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.015849 30680 slave.cpp:859] Successfully attached file '/tmp/MasterTest_MultipleExecutors_35KHSH/slaves/63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0/frameworks/63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000/executors/executor-1/runs/ecab473e-e790-4d14-b24c-c3684a8733e0' I0414 00:42:44.015956 30680 slave.cpp:1882] Authorizing task '2' for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.016016 30680 slave.cpp:6570] Authorizing framework principal 'test-principal' to launch task 2 I0414 00:42:44.016932 30681 slave.cpp:2069] Launching task '2' for framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.017431 30681 paths.cpp:554] Trying to chown '/tmp/MasterTest_MultipleExecutors_35KHSH/slaves/63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0/frameworks/63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000/executors/executor-2/runs/67215d43-d10d-4a09-9ac2-28b45043efc0' to user 'mesos' I0414 00:42:44.017529 30675 hierarchical.cpp:852] Updated allocation of framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 on agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-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] I0414 00:42:44.017683 30681 slave.cpp:6914] Launching executor 'executor-2' of framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_35KHSH/slaves/63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0/frameworks/63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000/executors/executor-2/runs/67215d43-d10d-4a09-9ac2-28b45043efc0' *** Aborted at 1492130564 (unix time) try "date -d @1492130564" if you are using GNU date *** PC: @ 0x2ac0d03df82d (unknown) I*** SIGSEGV (@0xd0) received by PID 30649 (TID 0x2ac0da05e700) from PID 208; stack trace: *** 0414 00:42:44.018537 30676 exec.cpp:162] Version: 1.3.0 I0414 00:42:44.018846 30675 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 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 from framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 I0414 00:42:44.018887 30680 exec.cpp:212] Executor started at: executor(75)@172.17.0.3:40085 with pid 30649 I0414 00:42:44.018947 30675 hierarchical.cpp:1153] Framework 63bbd5a3-0311-4824-b8bd-a5d4262020a1-0000 filtered agent 63bbd5a3-0311-4824-b8bd-a5d4262020a1-S0 for 5secs @ 0x2ac0edb7d2d7 (unknown) @ 0x2ac0edb815b9 (unknown) @ 0x2ac0d0196330 (unknown) @ 0x2ac0d03df82d (unknown) @ 0x2ac0c5c48287 os::getenv() @ 0x2ac0cd061d57 mesos::internal::slave::executorEnvironment() @ 0x2ac0cd0398f4 mesos::internal::slave::Slave::launchExecutor() @ 0x2ac0cd03523a mesos::internal::slave::Slave::__run() @ 0x2ac0cd09350b _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEES9_SC_SF_SK_SO_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_ENKUlPNS_11ProcessBaseEE_clES19_ @ 0x2ac0cd0cd3a0 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS5_13FrameworkInfoERKNS5_12ExecutorInfoERK6OptionINS5_8TaskInfoEERKSM_INS5_13TaskGroupInfoEESD_SG_SJ_SO_SS_EEvRKNS0_3PIDIT_EEMSW_FvT0_T1_T2_T3_T4_ET5_T6_T7_T8_T9_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_ @ 0x2ac0cde2d13f std::function<>::operator()() @ 0x2ac0cde12f2d process::ProcessBase::visit() @ 0x2ac0cde1d866 process::DispatchEvent::visit() @ 0x2ac0c5c1c776 process::ProcessBase::serve() @ 0x2ac0cde0f256 process::ProcessManager::resume() @ 0x2ac0cde0ba9a _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv @ 0x2ac0cde1cfa0 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE @ 0x2ac0cde1cef7 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv @ 0x2ac0cde1ce90 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2ac0cfa17a60 (unknown) @ 0x2ac0d018e184 start_thread @ 0x2ac0d04a1bed (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-1492127784-15630 Untagged: mesos-1492127784-15630:latest Deleted: sha256:ad5a56b3a3af5b8429952de1e166679a91dc0b92bfbf7874022d863fb3b694e9 Deleted: sha256:4cbbb370053eda5bcc2ca8a3f2d0e66207ccd4b9e0ee65ebd2dca13a950cc578 Deleted: sha256:e8d65cd033c00b1e0cb1b0773913b539b03aba5dbb3865d73da3e739879a1cd7 Deleted: sha256:668ecdaf3689c9808c96066bf720069fbc7a0d2e400ac61dd179cb6cad46a3f6 Deleted: sha256:8d398ed1459bcc5a4022d2b8b249c8837648b1887ca43b4361567e9dde2e6276 Deleted: sha256:d43fb59be95ba4ca88aee018089004b4f4c6ac9c5d354d039ae4ec900d58c228 Deleted: sha256:c9313e846fb5bd5a6b934c33d4caa3ac34b163889ee0c4e4869a164aef746347 Deleted: sha256:8c2409e91ad12fa77a09c11de50aa700ce2f14459a5e0b6d614faf700793a4ea Deleted: sha256:5d1ff4ad4a0d59b0c71e74961b59d4564191a1db0d71d2ef9e41e9c04ddd8f91 Deleted: sha256:b4b87ca5c2b410a91e38c8d0c4337e6727cbbe1dc6213d33591a19af0be8ef20 Deleted: sha256:f54e18e4a3f1bcbf395f69ef69e98733a850f2a9da67a80900f3323a6ea90112 Deleted: sha256:fbe6076ffe0027a14c8c77a14f61a5f297f3b617ef523753e7206fab02c323a1 Deleted: sha256:c71a6c2b9e12025aea3c50814a3ffe26c27e3dd6282ea7cb857068fb3da2a3d1 Deleted: sha256:b3b5357e19a73753da5168f1fb5f0524064784ce566fd086843a4a43192a3e30 Deleted: sha256:071756a433dbb7060bcaec62c84607e0bec8add3360ea901dd7caa8d496305a6 Deleted: sha256:70f1f13b6ed1c8fee19128782fe39f20f29cef01a99b9c5308bb296c269b5a68 Deleted: sha256:54bcafa969dc151714cfd71b9ce26d86455fedbf6e96a21d5b90b16c36f25865 Deleted: sha256:eb3c9c7e1065515e394a6bc44f6122dd4b89eb6815364dfa8d835d3edb23b253 Deleted: sha256:40187f688b521857b563dfa95cd09b683c50f3f7e39cc717218fa425254a78cc Deleted: sha256:a534b08ebd236fcdae7a6ab748d9d881a63c4c3ba17757123bd6135b70860b40 Deleted: sha256:01429487f738e32964fc59da0fad67ebafa38e53864e34a4cf30b9d3ffacd969 Deleted: sha256:562c44eda7a39f30e3e4221b394417b595fa558142e399db048c7db36a20d036 Deleted: sha256:450396dfe3d69f6d8414e76d32372410ed0f5ab7d1b21f6b1a029658061ca4d1 Deleted: sha256:c11a583de6a054af09edfecbc11aaa78d358ad7a65fb70ff2d615b4a138fa0e6 Build step 'Execute shell' marked build as failure
