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)/3298/display/redirect?page=changes>
Changes: [toenshoff] Fixed fetcher to not pick up environment variables it should not see. [toenshoff] Added regression test against fetcher SSL spillover. ------------------------------------------ [...truncated 10.84 MB...] I0223 06:09:01.268514 30939 exec.cpp:405] Executor::frameworkMessage took 78882ns I0223 06:09:01.268874 30934 slave.cpp:3105] Status update manager successfully handled status update acknowledgement (UUID: e2508b26-7e71-4aa3-a2d1-1e666b149fd7) for task 1 of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.269193 30931 slave.cpp:4324] Sending message for framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 to [email protected]:60105 I0223 06:09:01.269413 30943 sched.cpp:1177] Scheduler::frameworkMessage took 83841ns I0223 06:09:01.269673 30911 sched.cpp:2021] Asked to stop the driver I0223 06:09:01.269764 30937 sched.cpp:1203] Stopping framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.270066 30939 master.cpp:7705] Processing TEARDOWN call for framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 (default) at [email protected]:60105 I0223 06:09:01.270099 30939 master.cpp:7717] Removing framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 (default) at [email protected]:60105 I0223 06:09:01.270113 30939 master.cpp:3081] Deactivating framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 (default) at [email protected]:60105 I0223 06:09:01.270237 30941 hierarchical.cpp:415] Deactivated framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.270381 30939 master.cpp:8302] Updating the state of task 1 of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0223 06:09:01.270699 30935 slave.cpp:2658] Asked to shut down framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 by [email protected]:60105 I0223 06:09:01.270741 30935 slave.cpp:2683] Shutting down framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.270808 30935 slave.cpp:5083] Shutting down executor 'default' of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 at executor(74)@172.17.0.3:60105 I0223 06:09:01.271116 30931 exec.cpp:415] Executor asked to shutdown I0223 06:09:01.271167 30931 exec.cpp:430] Executor::shutdown took 36222ns I0223 06:09:01.271342 30937 slave.cpp:4388] Got exited event for executor(74)@172.17.0.3:60105 I0223 06:09:01.272007 30939 master.cpp:8396] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 on agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 at slave(179)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.272096 30943 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 ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 from framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.272409 30939 master.cpp:8425] Removing executor 'default' with resources {} of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 on agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 at slave(179)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.272876 30934 slave.cpp:4769] Executor 'default' of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 exited with status 0 I0223 06:09:01.272984 30934 slave.cpp:4869] Cleaning up executor 'default' of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 at executor(74)@172.17.0.3:60105 I0223 06:09:01.273136 30932 hierarchical.cpp:362] Removed framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 W0223 06:09:01.273135 30936 master.cpp:6278] Ignoring unknown exited executor 'default' of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 on agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 at slave(179)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.273236 30941 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_4fft2D/slaves/ea1a4bba-6408-43fe-973c-3c50a71d301a-S0/frameworks/ea1a4bba-6408-43fe-973c-3c50a71d301a-0000/executors/default/runs/f7edbc14-2518-4952-a8c4-3c592f2c2843' for gc 6.99999683839111days in the future I0223 06:09:01.273517 30934 slave.cpp:4957] Cleaning up framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.273527 30932 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_4fft2D/slaves/ea1a4bba-6408-43fe-973c-3c50a71d301a-S0/frameworks/ea1a4bba-6408-43fe-973c-3c50a71d301a-0000/executors/default' for gc 6.99999683498963days in the future I0223 06:09:01.273617 30931 status_update_manager.cpp:285] Closing status update streams for framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.273664 30931 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework ea1a4bba-6408-43fe-973c-3c50a71d301a-0000 I0223 06:09:01.273731 30936 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_4fft2D/slaves/ea1a4bba-6408-43fe-973c-3c50a71d301a-S0/frameworks/ea1a4bba-6408-43fe-973c-3c50a71d301a-0000' for gc 6.99999683268444days in the future I0223 06:09:01.273752 30934 slave.cpp:803] Agent terminating I0223 06:09:01.273998 30938 master.cpp:1264] Agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 at slave(179)@172.17.0.3:60105 (2667753041f6) disconnected I0223 06:09:01.274030 30938 master.cpp:3118] Disconnecting agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 at slave(179)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.274113 30938 master.cpp:3137] Deactivating agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 at slave(179)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.274229 30937 hierarchical.cpp:618] Agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 deactivated I0223 06:09:01.276129 30941 master.cpp:1103] Master terminating I0223 06:09:01.276626 30935 hierarchical.cpp:549] Removed agent ea1a4bba-6408-43fe-973c-3c50a71d301a-S0 [ OK ] MasterTest.FrameworkMessage (60 ms) [ RUN ] MasterTest.MultipleExecutors I0223 06:09:01.292263 30911 cluster.cpp:160] Creating default 'local' authorizer I0223 06:09:01.294844 30931 master.cpp:383] Master b8de096d-ce20-4d69-855c-f92d5a0c54ca (2667753041f6) started on 172.17.0.3:60105 I0223 06:09:01.294878 30931 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/6snpUQ/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.0/_inst/share/mesos/webui" --work_dir="/tmp/6snpUQ/master" --zk_session_timeout="10secs" I0223 06:09:01.295300 30931 master.cpp:435] Master only allowing authenticated frameworks to register I0223 06:09:01.295320 30931 master.cpp:449] Master only allowing authenticated agents to register I0223 06:09:01.295333 30931 master.cpp:462] Master only allowing authenticated HTTP frameworks to register I0223 06:09:01.295344 30931 credentials.hpp:37] Loading credentials for authentication from '/tmp/6snpUQ/credentials' I0223 06:09:01.295686 30931 master.cpp:507] Using default 'crammd5' authenticator I0223 06:09:01.295811 30931 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0223 06:09:01.295965 30931 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0223 06:09:01.296145 30931 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0223 06:09:01.296277 30931 master.cpp:587] Authorization enabled I0223 06:09:01.296421 30934 hierarchical.cpp:161] Initialized hierarchical allocator process I0223 06:09:01.296443 30932 whitelist_watcher.cpp:77] No whitelist given I0223 06:09:01.299005 30936 master.cpp:2124] Elected as the leading master! I0223 06:09:01.299036 30936 master.cpp:1646] Recovering from registrar I0223 06:09:01.299170 30941 registrar.cpp:329] Recovering registrar I0223 06:09:01.299667 30940 registrar.cpp:362] Successfully fetched the registry (0B) in 448us I0223 06:09:01.299779 30940 registrar.cpp:461] Applied 1 operations in 32030ns; attempting to update the registry I0223 06:09:01.300417 30935 registrar.cpp:506] Successfully updated the registry in 566016ns I0223 06:09:01.300528 30935 registrar.cpp:392] Successfully recovered registrar I0223 06:09:01.301049 30932 hierarchical.cpp:188] Skipping recovery of hierarchical allocator: nothing to recover I0223 06:09:01.301033 30939 master.cpp:1762] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0223 06:09:01.304795 30911 cluster.cpp:446] Creating default 'local' authorizer I0223 06:09:01.306229 30936 slave.cpp:211] Mesos agent started on (180)@172.17.0.3:60105 I0223 06:09:01.306288 30936 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_WMNqBs/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_WMNqBs/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_WMNqBs/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.2.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --qos_correction_interval_min="0ns" --quiet="false" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/MasterTest_MultipleExecutors_WMNqBs" --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_3GGUKE" I0223 06:09:01.306763 30936 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_WMNqBs/credential' I0223 06:09:01.306898 30936 slave.cpp:354] Agent using credential for: test-principal I0223 06:09:01.306920 30936 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_WMNqBs/http_credentials' I0223 06:09:01.307147 30936 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0223 06:09:01.307265 30936 http.cpp:919] Using default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0223 06:09:01.307695 30911 sched.cpp:232] Version: 1.2.0 I0223 06:09:01.308435 30942 sched.cpp:336] New master detected at [email protected]:60105 I0223 06:09:01.308528 30942 sched.cpp:407] Authenticating with master [email protected]:60105 I0223 06:09:01.308547 30942 sched.cpp:414] Using default CRAM-MD5 authenticatee I0223 06:09:01.308830 30942 authenticatee.cpp:121] Creating new client SASL connection I0223 06:09:01.308884 30936 slave.cpp:541] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0223 06:09:01.308997 30936 slave.cpp:549] Agent attributes: [ ] I0223 06:09:01.309011 30936 slave.cpp:554] Agent hostname: 2667753041f6 I0223 06:09:01.309168 30942 master.cpp:7163] Authenticating [email protected]:60105 I0223 06:09:01.309348 30942 status_update_manager.cpp:177] Pausing sending status updates I0223 06:09:01.309382 30942 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(412)@172.17.0.3:60105 I0223 06:09:01.309670 30942 authenticator.cpp:98] Creating new server SASL connection I0223 06:09:01.310336 30935 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0223 06:09:01.310381 30935 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0223 06:09:01.310428 30943 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_3GGUKE/meta' I0223 06:09:01.310499 30937 authenticator.cpp:204] Received SASL authentication start I0223 06:09:01.310562 30937 authenticator.cpp:326] Authentication requires more steps I0223 06:09:01.310745 30939 status_update_manager.cpp:203] Recovering status update manager I0223 06:09:01.310786 30937 authenticatee.cpp:259] Received SASL authentication step I0223 06:09:01.311041 30930 authenticator.cpp:232] Received SASL authentication step I0223 06:09:01.311084 30930 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2667753041f6' server FQDN: '2667753041f6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0223 06:09:01.311107 30930 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0223 06:09:01.311122 30935 slave.cpp:5558] Finished recovery I0223 06:09:01.311161 30930 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0223 06:09:01.311195 30930 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2667753041f6' server FQDN: '2667753041f6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0223 06:09:01.311213 30930 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0223 06:09:01.311228 30930 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0223 06:09:01.311252 30930 authenticator.cpp:318] Authentication success I0223 06:09:01.311341 30939 authenticatee.cpp:299] Authentication success I0223 06:09:01.311416 30937 master.cpp:7193] Successfully authenticated principal 'test-principal' at [email protected]:60105 I0223 06:09:01.311441 30939 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(412)@172.17.0.3:60105 I0223 06:09:01.311712 30935 slave.cpp:5732] Querying resource estimator for oversubscribable resources I0223 06:09:01.311975 30932 sched.cpp:513] Successfully authenticated with master [email protected]:60105 I0223 06:09:01.312002 30932 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:60105 I0223 06:09:01.312016 30937 status_update_manager.cpp:177] Pausing sending status updates I0223 06:09:01.312019 30935 slave.cpp:931] New master detected at [email protected]:60105 I0223 06:09:01.312103 30935 slave.cpp:966] Detecting new master I0223 06:09:01.312101 30932 sched.cpp:869] Will retry registration in 814.815448ms if necessary I0223 06:09:01.312228 30935 slave.cpp:5746] Received oversubscribable resources {} from the resource estimator I0223 06:09:01.312235 30943 master.cpp:2737] Received SUBSCRIBE call for framework 'default' at [email protected]:60105 I0223 06:09:01.312261 30943 master.cpp:2160] Authorizing framework principal 'test-principal' to receive offers for role '*' I0223 06:09:01.312638 30938 master.cpp:2813] Subscribing framework default with checkpointing disabled and capabilities [ ] I0223 06:09:01.313079 30939 sched.cpp:759] Framework registered with b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.313127 30939 sched.cpp:773] Scheduler::registered took 30954ns I0223 06:09:01.313171 30940 hierarchical.cpp:286] Added framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.313287 30940 hierarchical.cpp:1810] No allocations performed I0223 06:09:01.313319 30940 hierarchical.cpp:1900] No inverse offers to send out! I0223 06:09:01.313352 30940 hierarchical.cpp:1394] Performed allocation for 0 agents in 107541ns I0223 06:09:01.314250 30934 slave.cpp:993] Authenticating with master [email protected]:60105 I0223 06:09:01.314313 30934 slave.cpp:1004] Using default CRAM-MD5 authenticatee I0223 06:09:01.314498 30938 authenticatee.cpp:121] Creating new client SASL connection I0223 06:09:01.314718 30938 master.cpp:7163] Authenticating slave(180)@172.17.0.3:60105 I0223 06:09:01.314813 30942 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(413)@172.17.0.3:60105 I0223 06:09:01.315066 30939 authenticator.cpp:98] Creating new server SASL connection I0223 06:09:01.315270 30938 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0223 06:09:01.315320 30938 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0223 06:09:01.315415 30941 authenticator.cpp:204] Received SASL authentication start I0223 06:09:01.315477 30941 authenticator.cpp:326] Authentication requires more steps I0223 06:09:01.315569 30931 authenticatee.cpp:259] Received SASL authentication step I0223 06:09:01.315852 30941 authenticator.cpp:232] Received SASL authentication step I0223 06:09:01.315886 30941 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2667753041f6' server FQDN: '2667753041f6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0223 06:09:01.315901 30941 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0223 06:09:01.315929 30941 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0223 06:09:01.315948 30941 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '2667753041f6' server FQDN: '2667753041f6' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0223 06:09:01.315958 30941 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0223 06:09:01.315968 30941 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0223 06:09:01.315982 30941 authenticator.cpp:318] Authentication success I0223 06:09:01.316066 30938 authenticatee.cpp:299] Authentication success I0223 06:09:01.316121 30933 master.cpp:7193] Successfully authenticated principal 'test-principal' at slave(180)@172.17.0.3:60105 I0223 06:09:01.316185 30943 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(413)@172.17.0.3:60105 I0223 06:09:01.316360 30934 slave.cpp:1088] Successfully authenticated with master [email protected]:60105 I0223 06:09:01.316510 30934 slave.cpp:1515] Will retry registration in 14.243948ms if necessary I0223 06:09:01.316674 30935 master.cpp:5378] Registering agent at slave(180)@172.17.0.3:60105 (2667753041f6) with id b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 I0223 06:09:01.316957 30933 registrar.cpp:461] Applied 1 operations in 59174ns; attempting to update the registry I0223 06:09:01.318198 30933 registrar.cpp:506] Successfully updated the registry in 1.185024ms I0223 06:09:01.318819 30937 slave.cpp:4346] Received ping from slave-observer(178)@172.17.0.3:60105 I0223 06:09:01.319025 30940 slave.cpp:1134] Registered with master [email protected]:60105; given agent ID b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 I0223 06:09:01.319053 30940 fetcher.cpp:94] Clearing fetcher cache I0223 06:09:01.318985 30944 master.cpp:5452] Registered agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0223 06:09:01.319186 30937 status_update_manager.cpp:184] Resuming sending status updates I0223 06:09:01.319232 30934 hierarchical.cpp:516] Added agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 (2667753041f6) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0223 06:09:01.319360 30940 slave.cpp:1162] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_3GGUKE/meta/slaves/b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0/slave.info' I0223 06:09:01.319680 30940 slave.cpp:1200] Forwarding total oversubscribed resources {} I0223 06:09:01.319819 30933 master.cpp:6009] Received update of agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) with total oversubscribed resources {} I0223 06:09:01.320332 30934 hierarchical.cpp:1900] No inverse offers to send out! I0223 06:09:01.320389 30934 hierarchical.cpp:1394] Performed allocation for 1 agents in 1.067921ms I0223 06:09:01.320565 30934 hierarchical.cpp:589] Agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 (2667753041f6) 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]) I0223 06:09:01.320773 30934 hierarchical.cpp:1810] No allocations performed I0223 06:09:01.320819 30934 hierarchical.cpp:1900] No inverse offers to send out! I0223 06:09:01.320866 30934 hierarchical.cpp:1394] Performed allocation for 1 agents in 188639ns I0223 06:09:01.321151 30940 master.cpp:6992] Sending 1 offers to framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 (default) at [email protected]:60105 I0223 06:09:01.321719 30939 sched.cpp:933] Scheduler::resourceOffers took 162535ns I0223 06:09:01.324185 30939 master.cpp:3776] Processing ACCEPT call for offers: [ b8de096d-ce20-4d69-855c-f92d5a0c54ca-O0 ] on agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) for framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 (default) at [email protected]:60105 I0223 06:09:01.324273 30939 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 1 I0223 06:09:01.324501 30939 master.cpp:3352] Authorizing framework principal 'test-principal' to launch task 2 W0223 06:09:01.326114 30939 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. W0223 06:09:01.326143 30939 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. I0223 06:09:01.326445 30939 master.cpp:9053] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.326580 30939 master.cpp:4426] Launching task 1 of framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 (default) at [email protected]:60105 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.327042 30940 slave.cpp:1625] Got assigned task '1' for framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.327575 30940 slave.cpp:1785] Launching task '1' for framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 W0223 06:09:01.327664 30939 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. W0223 06:09:01.327690 30939 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. I0223 06:09:01.328065 30939 master.cpp:9053] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.328249 30940 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_3GGUKE/slaves/b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0/frameworks/b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000/executors/executor-1/runs/c4601f2e-bbb4-486d-8bec-5ce672c2f61d' to user 'mesos' I0223 06:09:01.328258 30939 master.cpp:4426] Launching task 2 of framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 (default) at [email protected]:60105 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 at slave(180)@172.17.0.3:60105 (2667753041f6) I0223 06:09:01.328470 30940 slave.cpp:6480] Launching executor 'executor-1' of framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_3GGUKE/slaves/b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0/frameworks/b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000/executors/executor-1/runs/c4601f2e-bbb4-486d-8bec-5ce672c2f61d' I0223 06:09:01.329057 30940 slave.cpp:2118] Queued task '1' for executor 'executor-1' of framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.329399 30940 slave.cpp:1625] Got assigned task '2' for framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.330269 30940 slave.cpp:884] Successfully attached file '/tmp/MasterTest_MultipleExecutors_3GGUKE/slaves/b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0/frameworks/b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000/executors/executor-1/runs/c4601f2e-bbb4-486d-8bec-5ce672c2f61d' I0223 06:09:01.330376 30940 slave.cpp:1785] Launching task '2' for framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.331173 30940 paths.cpp:547] Trying to chown '/tmp/MasterTest_MultipleExecutors_3GGUKE/slaves/b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0/frameworks/b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000/executors/executor-2/runs/36dafd7d-3108-4b6e-9d6d-b4e877ff928d' to user 'mesos' I0223 06:09:01.331429 30929 hierarchical.cpp:807] Updated allocation of framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 on agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-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] I0223 06:09:01.331473 30940 slave.cpp:6480] Launching executor 'executor-2' of framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_3GGUKE/slaves/b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0/frameworks/b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000/executors/executor-2/runs/36dafd7d-3108-4b6e-9d6d-b4e877ff928d' *** Aborted at 1487830141 (unix time) try "date -d @1487830141" if you are using GNU date *** PC: @ 0x2b2f24f7882d (unknown) I0223 06:09:01.332197 30934 exec.cpp:162] Version: 1.2.0 I0223 06:09:01.332192 30929 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 b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 from framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 I0223 06:09:01.332240 30929 hierarchical.cpp:1101] Framework b8de096d-ce20-4d69-855c-f92d5a0c54ca-0000 filtered agent b8de096d-ce20-4d69-855c-f92d5a0c54ca-S0 for 5secs I0223 06:09:01.332432 30933 exec.cpp:212] Executor started at: executor(75)@172.17.0.3:60105 with pid 30911 *** SIGSEGV (@0xb0) received by PID 30911 (TID 0x2b2f2f230700) from PID 176; stack trace: *** @ 0x2b2f66cdf2d7 (unknown) @ 0x2b2f66ce35b9 (unknown) @ 0x2b2f24d2f330 (unknown) @ 0x2b2f24f7882d (unknown) @ 0x2b2f1abb5ba8 os::getenv() @ 0x2b2f212cd8ef mesos::internal::slave::executorEnvironment() @ 0x2b2f212aaaad mesos::internal::slave::Framework::launchExecutor() @ 0x2b2f212a7b24 mesos::internal::slave::Slave::_run() @ 0x2b2f213461b0 _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_ @ 0x2b2f21345c5f _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_ @ 0x2b2f2245af34 std::function<>::operator()() @ 0x2b2f22442524 process::ProcessBase::visit() @ 0x2b2f224b879e process::DispatchEvent::visit() @ 0x2b2f1ab9b641 process::ProcessBase::serve() @ 0x2b2f2243ffb7 process::ProcessManager::resume() @ 0x2b2f2244e37c process::ProcessManager::init_threads()::$_2::operator()() @ 0x2b2f2244e285 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_2vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE @ 0x2b2f2244e255 std::_Bind_simple<>::operator()() @ 0x2b2f2244e22c std::thread::_Impl<>::_M_run() @ 0x2b2f245b0a60 (unknown) @ 0x2b2f24d27184 start_thread @ 0x2b2f2503737d (unknown) make[4]: *** [check-local] Segmentation fault make[4]: Leaving directory `/mesos/mesos-1.2.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.2.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.2.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.2.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1487827016-10659 Untagged: mesos-1487827016-10659:latest Deleted: sha256:aeed677f71e29a27e638677d8df598851c4cc0576cc092a23501f882ac0569fb Deleted: sha256:4f4763b9674a9b86f9666a40998b46a3a1d782f7c36534a45cff50799af28cf2 Deleted: sha256:b2dd69f1040c503139c5bc124a1a8d885752e46b0deee891c4f39954f729d08d Deleted: sha256:9edb246c30a565bd1cb92fc30d1d4c4e96d11617ae1bc6be9a477e7bf80e01da Deleted: sha256:b9f5d3ec39db70d10d36ff85700900149af92fa81d8f03f5706d1afabd28edb2 Deleted: sha256:458a0df35432089272ff5b3d13ba706bb2bd2490d17c8f41da29d4421cd384ae Deleted: sha256:d29e32c5d81d41446f8a093743ab2e12305b23ba2055784132b6241c9b1e567e Deleted: sha256:2134d5dfbf8bfc2daf96c87f29f0ec7abdb4c818f0bb7d3db8337b99f335d96c Deleted: sha256:24184c5559b3b54375100bcda3b289543a1ff9da57b46190ee4355626eddc7b0 Deleted: sha256:641b91fb048e6f925ac6240de80179ae5e5016b3c24207527aaf863956a71f4e Deleted: sha256:f0c9d276db29a6875d6000f7437c2e4396bf5d8b7ac75579e0bc5b4ce06dd0e1 Deleted: sha256:80641abb822868116f83217ff5f9ca9e359809c0ae4608eae18627b89f532d48 Deleted: sha256:70cda336bce51db85380738fe00df5567c25588b40ec36661c190e33add4b94d Deleted: sha256:39c53c39d223c05cb534f3218578a00e5d33d9cf8c6d2e63b03b5656383f43c6 Deleted: sha256:51302effe38fdf27297ed15b495bb092ea75c706491a3c2d5ecc807639f17228 Deleted: sha256:12da983440561ded9f777fdc55188d946b3b03eca84a0996cdbb962581a78925 Deleted: sha256:5db66f08f1ff920baa7b49bc087e3926a8ee7bf573d5c75a8eb5bd20c140b632 Deleted: sha256:2f7db0833a06053a54c86f6225bcade90c21f67478dd9d34cb3ecdaddc57e271 Deleted: sha256:4d97f03e34a8e7d450bd8cb98a6f96b2ee0b5f2aae19c320e923b2daa0357a1f Deleted: sha256:c6b6f0e162389cbc37d8dde32cb5223bad87f9e0efe38cefbf2993447a6744ad Deleted: sha256:57270f0b74d14c8c2eda6d4675b409296752bd26ae11cce6a1fdb8254feb9a63 Deleted: sha256:362d5fd3850047578214509d9a96c0d846a0cf6b4cc311f785f369ada0cbdcf1 Deleted: sha256:ac2068dc9540d6025d954504cefaa6d476943acaeafda31d047029940d5b6bab Deleted: sha256:478488bb3a2779f73e899321b882b0994180ecbb6e139d7f7e882f1c8b6bdcfa Build step 'Execute shell' marked build as failure
