See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3459/display/redirect?page=changes>
Changes: [neil.conway] Added stringify overload specialized for std::string. [neil.conway] Avoided excessive copying in the default implementation of 'stringify'. ------------------------------------------ [...truncated 12.24 MB...] I0410 20:49:10.931422 24424 status_update_manager.cpp:500] Creating StatusUpdate stream for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.931572 24424 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 to the agent I0410 20:49:10.931686 24429 slave.cpp:4621] Forwarding the update TASK_RUNNING (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 to [email protected]:60871 I0410 20:49:10.931793 24429 slave.cpp:4515] Status update manager successfully handled status update TASK_RUNNING (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.931823 24429 slave.cpp:4531] Sending acknowledgement for status update TASK_RUNNING (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 to executor(120)@172.17.0.2:60871 I0410 20:49:10.931915 24434 exec.cpp:374] Executor received status update acknowledgement 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89 for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.931910 24422 master.cpp:6260] Status update TASK_RUNNING (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 from agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.931953 24422 master.cpp:6328] Forwarding status update TASK_RUNNING (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.932032 24422 master.cpp:8362] Updating the state of task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0410 20:49:10.932150 24431 sched.cpp:1041] Scheduler::statusUpdate took 64283ns I0410 20:49:10.932354 24427 master.cpp:5168] Processing ACKNOWLEDGE call 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89 for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 (default) at [email protected]:60871 on agent c488f39a-bc21-437d-a648-21958c0287a5-S0 I0410 20:49:10.932612 24430 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.932705 24426 exec.cpp:396] Executor received framework message I0410 20:49:10.932731 24421 slave.cpp:3470] Status update manager successfully handled status update acknowledgement (UUID: 1b9929b4-2f52-4d1c-b1f5-b4bdfead2b89) for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.932772 24426 exec.cpp:405] Executor::frameworkMessage took 42432ns I0410 20:49:10.933197 24425 slave.cpp:4689] Sending message for framework c488f39a-bc21-437d-a648-21958c0287a5-0000 to [email protected]:60871 I0410 20:49:10.933372 24426 sched.cpp:1177] Scheduler::frameworkMessage took 89902ns I0410 20:49:10.933698 24418 sched.cpp:2021] Asked to stop the driver I0410 20:49:10.933759 24426 sched.cpp:1203] Stopping framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.933873 24424 master.cpp:7782] Processing TEARDOWN call for framework c488f39a-bc21-437d-a648-21958c0287a5-0000 (default) at [email protected]:60871 I0410 20:49:10.933905 24424 master.cpp:7794] Removing framework c488f39a-bc21-437d-a648-21958c0287a5-0000 (default) at [email protected]:60871 I0410 20:49:10.934000 24424 master.cpp:3165] Deactivating framework c488f39a-bc21-437d-a648-21958c0287a5-0000 (default) at [email protected]:60871 I0410 20:49:10.934101 24420 hierarchical.cpp:376] Deactivated framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.934136 24424 master.cpp:8362] Updating the state of task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0410 20:49:10.934221 24423 slave.cpp:3023] Asked to shut down framework c488f39a-bc21-437d-a648-21958c0287a5-0000 by [email protected]:60871 I0410 20:49:10.934252 24423 slave.cpp:3048] Shutting down framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.934268 24423 slave.cpp:5441] Shutting down executor 'default' of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 at executor(120)@172.17.0.2:60871 I0410 20:49:10.934412 24422 exec.cpp:415] Executor asked to shutdown I0410 20:49:10.934394 24424 master.cpp:8456] Removing task 1 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 on agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.934456 24422 exec.cpp:430] Executor::shutdown took 23205ns I0410 20:49:10.934537 24424 master.cpp:8485] Removing executor 'default' with resources {} of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 on agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.934576 24422 slave.cpp:4753] Got exited event for executor(120)@172.17.0.2:60871 I0410 20:49:10.934679 24425 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 c488f39a-bc21-437d-a648-21958c0287a5-S0 from framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.934876 24425 hierarchical.cpp:323] Removed framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.935241 24422 slave.cpp:5127] Executor 'default' of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 exited with status 0 I0410 20:49:10.935300 24422 slave.cpp:5227] Cleaning up executor 'default' of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 at executor(120)@172.17.0.2:60871 W0410 20:49:10.935356 24433 master.cpp:6384] Ignoring unknown exited executor 'default' of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 on agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.935487 24432 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_nvymPw/slaves/c488f39a-bc21-437d-a648-21958c0287a5-S0/frameworks/c488f39a-bc21-437d-a648-21958c0287a5-0000/executors/default/runs/cb0a3809-41bd-4341-8c79-1c570e076cc9' for gc 6.99998917344889days in the future I0410 20:49:10.935539 24422 slave.cpp:5315] Cleaning up framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.935588 24432 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_nvymPw/slaves/c488f39a-bc21-437d-a648-21958c0287a5-S0/frameworks/c488f39a-bc21-437d-a648-21958c0287a5-0000/executors/default' for gc 6.99998917219852days in the future I0410 20:49:10.935618 24428 status_update_manager.cpp:285] Closing status update streams for framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.935647 24428 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework c488f39a-bc21-437d-a648-21958c0287a5-0000 I0410 20:49:10.935717 24433 gc.cpp:55] Scheduling '/tmp/MasterTest_FrameworkMessage_nvymPw/slaves/c488f39a-bc21-437d-a648-21958c0287a5-S0/frameworks/c488f39a-bc21-437d-a648-21958c0287a5-0000' for gc 6.99998917074074days in the future I0410 20:49:10.935933 24420 slave.cpp:756] Agent terminating I0410 20:49:10.936055 24432 master.cpp:1318] Agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) disconnected I0410 20:49:10.936084 24432 master.cpp:3202] Disconnecting agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.936146 24432 master.cpp:3221] Deactivating agent c488f39a-bc21-437d-a648-21958c0287a5-S0 at slave(298)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.936238 24434 hierarchical.cpp:655] Agent c488f39a-bc21-437d-a648-21958c0287a5-S0 deactivated I0410 20:49:10.937453 24418 master.cpp:1157] Master terminating I0410 20:49:10.937713 24430 hierarchical.cpp:560] Removed agent c488f39a-bc21-437d-a648-21958c0287a5-S0 [ OK ] MasterTest.FrameworkMessage (36 ms) [ RUN ] MasterTest.MultipleExecutors I0410 20:49:10.945148 24418 cluster.cpp:162] Creating default 'local' authorizer I0410 20:49:10.946274 24426 master.cpp:438] Master af6eac18-a7d2-4493-87bd-dc696e54958c (697b00680f72) started on 172.17.0.2:60871 I0410 20:49:10.946300 24426 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/nbJv7i/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="/usr/local/share/mesos/webui" --work_dir="/tmp/nbJv7i/master" --zk_session_timeout="10secs" I0410 20:49:10.946493 24426 master.cpp:490] Master only allowing authenticated frameworks to register I0410 20:49:10.946504 24426 master.cpp:504] Master only allowing authenticated agents to register I0410 20:49:10.946511 24426 master.cpp:517] Master only allowing authenticated HTTP frameworks to register I0410 20:49:10.946522 24426 credentials.hpp:37] Loading credentials for authentication from '/tmp/nbJv7i/credentials' I0410 20:49:10.946678 24426 master.cpp:562] Using default 'crammd5' authenticator I0410 20:49:10.946730 24426 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0410 20:49:10.946802 24426 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0410 20:49:10.946872 24426 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0410 20:49:10.946950 24426 master.cpp:642] Authorization enabled I0410 20:49:10.947012 24427 whitelist_watcher.cpp:77] No whitelist given I0410 20:49:10.947033 24433 hierarchical.cpp:159] Initialized hierarchical allocator process I0410 20:49:10.947871 24426 master.cpp:2166] Elected as the leading master! I0410 20:49:10.947887 24426 master.cpp:1705] Recovering from registrar I0410 20:49:10.947996 24424 registrar.cpp:331] Recovering registrar I0410 20:49:10.948307 24419 registrar.cpp:364] Successfully fetched the registry (0B) in 267264ns I0410 20:49:10.948339 24419 registrar.cpp:463] Applied 1 operations in 2782ns; attempting to update the registry I0410 20:49:10.948686 24431 registrar.cpp:508] Successfully updated the registry in 284160ns I0410 20:49:10.948745 24431 registrar.cpp:394] Successfully recovered registrar I0410 20:49:10.949026 24427 master.cpp:1804] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0410 20:49:10.949050 24433 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover I0410 20:49:10.951378 24418 cluster.cpp:448] Creating default 'local' authorizer I0410 20:49:10.951963 24427 slave.cpp:225] Mesos agent started on (299)@172.17.0.2:60871 I0410 20:49:10.951987 24427 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_3tN8oH/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_3tN8oH/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_3tN8oH/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --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_3tN8oH" --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_nfBjg0" I0410 20:49:10.952208 24427 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_3tN8oH/credential' I0410 20:49:10.952307 24427 slave.cpp:258] Agent using credential for: test-principal I0410 20:49:10.952327 24427 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_3tN8oH/http_credentials' I0410 20:49:10.952440 24427 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0410 20:49:10.952494 24427 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0410 20:49:10.952739 24418 sched.cpp:232] Version: 1.3.0 I0410 20:49:10.952975 24430 sched.cpp:336] New master detected at [email protected]:60871 I0410 20:49:10.953019 24430 sched.cpp:407] Authenticating with master [email protected]:60871 I0410 20:49:10.953038 24430 sched.cpp:414] Using default CRAM-MD5 authenticatee I0410 20:49:10.953052 24427 slave.cpp:491] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0410 20:49:10.953095 24427 slave.cpp:499] Agent attributes: [ ] I0410 20:49:10.953104 24427 slave.cpp:504] Agent hostname: 697b00680f72 I0410 20:49:10.953142 24421 authenticatee.cpp:121] Creating new client SASL connection I0410 20:49:10.953213 24430 status_update_manager.cpp:177] Pausing sending status updates I0410 20:49:10.953299 24421 master.cpp:7269] Authenticating [email protected]:60871 I0410 20:49:10.953362 24421 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(644)@172.17.0.2:60871 I0410 20:49:10.953441 24427 authenticator.cpp:98] Creating new server SASL connection I0410 20:49:10.953475 24421 state.cpp:62] Recovering state from '/tmp/MasterTest_MultipleExecutors_nfBjg0/meta' I0410 20:49:10.953701 24419 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0410 20:49:10.953703 24427 status_update_manager.cpp:203] Recovering status update manager I0410 20:49:10.953748 24419 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0410 20:49:10.953800 24419 authenticator.cpp:204] Received SASL authentication start I0410 20:49:10.953856 24419 authenticator.cpp:326] Authentication requires more steps I0410 20:49:10.953958 24425 slave.cpp:5929] Finished recovery I0410 20:49:10.953992 24422 authenticatee.cpp:259] Received SASL authentication step I0410 20:49:10.954072 24422 authenticator.cpp:232] Received SASL authentication step I0410 20:49:10.954093 24422 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '697b00680f72' server FQDN: '697b00680f72' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0410 20:49:10.954102 24422 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0410 20:49:10.954113 24422 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0410 20:49:10.954123 24422 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '697b00680f72' server FQDN: '697b00680f72' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0410 20:49:10.954131 24422 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0410 20:49:10.954138 24422 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0410 20:49:10.954149 24422 authenticator.cpp:318] Authentication success I0410 20:49:10.954242 24423 authenticatee.cpp:299] Authentication success I0410 20:49:10.954262 24420 master.cpp:7299] Successfully authenticated principal 'test-principal' at [email protected]:60871 I0410 20:49:10.954284 24421 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(644)@172.17.0.2:60871 I0410 20:49:10.954365 24423 sched.cpp:513] Successfully authenticated with master [email protected]:60871 I0410 20:49:10.954380 24425 slave.cpp:6111] Querying resource estimator for oversubscribable resources I0410 20:49:10.954380 24423 sched.cpp:836] Sending SUBSCRIBE call to [email protected]:60871 I0410 20:49:10.954454 24423 sched.cpp:869] Will retry registration in 71.648579ms if necessary I0410 20:49:10.954511 24425 slave.cpp:884] New master detected at [email protected]:60871 I0410 20:49:10.954520 24423 status_update_manager.cpp:177] Pausing sending status updates I0410 20:49:10.954524 24424 master.cpp:2818] Received SUBSCRIBE call for framework 'default' at [email protected]:60871 I0410 20:49:10.954545 24425 slave.cpp:919] Detecting new master I0410 20:49:10.954552 24424 master.cpp:2202] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0410 20:49:10.954638 24425 slave.cpp:6125] Received oversubscribable resources {} from the resource estimator I0410 20:49:10.954732 24431 master.cpp:2895] Subscribing framework default with checkpointing disabled and capabilities [ ] I0410 20:49:10.954898 24434 hierarchical.cpp:271] Added framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.954921 24432 sched.cpp:759] Framework registered with af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.954957 24434 hierarchical.cpp:1862] No allocations performed I0410 20:49:10.954960 24432 sched.cpp:773] Scheduler::registered took 23596ns I0410 20:49:10.954977 24434 hierarchical.cpp:1952] No inverse offers to send out! I0410 20:49:10.954990 24434 hierarchical.cpp:1446] Performed allocation for 0 agents in 39103ns I0410 20:49:10.962780 24422 slave.cpp:946] Authenticating with master [email protected]:60871 I0410 20:49:10.962812 24422 slave.cpp:957] Using default CRAM-MD5 authenticatee I0410 20:49:10.962934 24428 authenticatee.cpp:121] Creating new client SASL connection I0410 20:49:10.963110 24428 master.cpp:7269] Authenticating slave(299)@172.17.0.2:60871 I0410 20:49:10.963191 24422 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(645)@172.17.0.2:60871 I0410 20:49:10.963366 24428 authenticator.cpp:98] Creating new server SASL connection I0410 20:49:10.963505 24425 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0410 20:49:10.963523 24425 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0410 20:49:10.963626 24431 authenticator.cpp:204] Received SASL authentication start I0410 20:49:10.963670 24431 authenticator.cpp:326] Authentication requires more steps I0410 20:49:10.963723 24431 authenticatee.cpp:259] Received SASL authentication step I0410 20:49:10.963793 24433 authenticator.cpp:232] Received SASL authentication step I0410 20:49:10.963819 24433 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '697b00680f72' server FQDN: '697b00680f72' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0410 20:49:10.963830 24433 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0410 20:49:10.963841 24433 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0410 20:49:10.963852 24433 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '697b00680f72' server FQDN: '697b00680f72' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0410 20:49:10.963865 24433 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0410 20:49:10.963877 24433 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0410 20:49:10.963889 24433 authenticator.cpp:318] Authentication success I0410 20:49:10.963937 24420 authenticatee.cpp:299] Authentication success I0410 20:49:10.963958 24432 master.cpp:7299] Successfully authenticated principal 'test-principal' at slave(299)@172.17.0.2:60871 I0410 20:49:10.963996 24433 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(645)@172.17.0.2:60871 I0410 20:49:10.964118 24428 slave.cpp:1041] Successfully authenticated with master [email protected]:60871 I0410 20:49:10.964179 24428 slave.cpp:1469] Will retry registration in 3.472396ms if necessary I0410 20:49:10.964283 24421 master.cpp:5454] Registering agent at slave(299)@172.17.0.2:60871 (697b00680f72) with id af6eac18-a7d2-4493-87bd-dc696e54958c-S0 I0410 20:49:10.964453 24419 registrar.cpp:463] Applied 1 operations in 20572ns; attempting to update the registry I0410 20:49:10.964931 24419 registrar.cpp:508] Successfully updated the registry in 442880ns I0410 20:49:10.965191 24419 master.cpp:5528] Registered agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0410 20:49:10.965340 24419 hierarchical.cpp:527] Added agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 (697b00680f72) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0410 20:49:10.965667 24419 hierarchical.cpp:1952] No inverse offers to send out! I0410 20:49:10.965689 24419 hierarchical.cpp:1446] Performed allocation for 1 agents in 282554ns I0410 20:49:10.965728 24419 slave.cpp:1087] Registered with master [email protected]:60871; given agent ID af6eac18-a7d2-4493-87bd-dc696e54958c-S0 I0410 20:49:10.965744 24419 fetcher.cpp:94] Clearing fetcher cache I0410 20:49:10.966053 24419 slave.cpp:1115] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_nfBjg0/meta/slaves/af6eac18-a7d2-4493-87bd-dc696e54958c-S0/slave.info' I0410 20:49:10.966414 24419 slave.cpp:1153] Forwarding total oversubscribed resources {} I0410 20:49:10.966475 24419 slave.cpp:4711] Received ping from slave-observer(293)@172.17.0.2:60871 I0410 20:49:10.966518 24433 master.cpp:7098] Sending 1 offers to framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 (default) at [email protected]:60871 I0410 20:49:10.966534 24419 status_update_manager.cpp:184] Resuming sending status updates I0410 20:49:10.966650 24433 master.cpp:6115] Received update of agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) with total oversubscribed resources {} I0410 20:49:10.966754 24419 sched.cpp:933] Scheduler::resourceOffers took 56506ns I0410 20:49:10.967555 24424 master.cpp:3856] Processing ACCEPT call for offers: [ af6eac18-a7d2-4493-87bd-dc696e54958c-O0 ] on agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 (default) at [email protected]:60871 I0410 20:49:10.967603 24424 master.cpp:3432] Authorizing framework principal 'test-principal' to launch task 1 I0410 20:49:10.967699 24424 master.cpp:3432] Authorizing framework principal 'test-principal' to launch task 2 W0410 20:49:10.968389 24430 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. W0410 20:49:10.968416 24430 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. I0410 20:49:10.968508 24430 master.cpp:9114] Adding task 1 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.968572 24430 master.cpp:4506] Launching task 1 of framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 (default) at [email protected]:60871 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.968749 24421 slave.cpp:1579] Got assigned task '1' for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 W0410 20:49:10.968922 24430 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. W0410 20:49:10.968946 24430 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. I0410 20:49:10.969035 24430 master.cpp:9114] Adding task 2 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.969060 24421 slave.cpp:1860] Authorizing task '1' for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.969094 24421 slave.cpp:6548] Authorizing framework principal 'test-principal' to launch task 1 I0410 20:49:10.969095 24430 master.cpp:4506] Launching task 2 of framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 (default) at [email protected]:60871 with resources cpus(*)(allocated: *):1; mem(*)(allocated: *):512 on agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 at slave(299)@172.17.0.2:60871 (697b00680f72) I0410 20:49:10.969831 24420 hierarchical.cpp:852] Updated allocation of framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 on agent af6eac18-a7d2-4493-87bd-dc696e54958c-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] I0410 20:49:10.970010 24420 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 af6eac18-a7d2-4493-87bd-dc696e54958c-S0 from framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.970043 24420 hierarchical.cpp:1153] Framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 filtered agent af6eac18-a7d2-4493-87bd-dc696e54958c-S0 for 5secs I0410 20:49:10.970168 24421 slave.cpp:1579] Got assigned task '2' for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.970382 24421 slave.cpp:2047] Launching task '1' for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.970907 24421 paths.cpp:554] Trying to chown '/tmp/MasterTest_MultipleExecutors_nfBjg0/slaves/af6eac18-a7d2-4493-87bd-dc696e54958c-S0/frameworks/af6eac18-a7d2-4493-87bd-dc696e54958c-0000/executors/executor-1/runs/9d9b94ce-8bbb-4ece-b57a-5c19d6e9670d' to user 'mesos' I0410 20:49:10.971096 24421 slave.cpp:6892] Launching executor 'executor-1' of framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_nfBjg0/slaves/af6eac18-a7d2-4493-87bd-dc696e54958c-S0/frameworks/af6eac18-a7d2-4493-87bd-dc696e54958c-0000/executors/executor-1/runs/9d9b94ce-8bbb-4ece-b57a-5c19d6e9670d' I0410 20:49:10.971312 24421 slave.cpp:2276] Queued task '1' for executor 'executor-1' of framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.971364 24421 slave.cpp:1860] Authorizing task '2' for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.971387 24421 slave.cpp:6548] Authorizing framework principal 'test-principal' to launch task 2 I0410 20:49:10.971554 24421 slave.cpp:837] Successfully attached file '/tmp/MasterTest_MultipleExecutors_nfBjg0/slaves/af6eac18-a7d2-4493-87bd-dc696e54958c-S0/frameworks/af6eac18-a7d2-4493-87bd-dc696e54958c-0000/executors/executor-1/runs/9d9b94ce-8bbb-4ece-b57a-5c19d6e9670d' I0410 20:49:10.971752 24431 slave.cpp:2047] Launching task '2' for framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 I0410 20:49:10.972173 24431 paths.cpp:554] Trying to chown '/tmp/MasterTest_MultipleExecutors_nfBjg0/slaves/af6eac18-a7d2-4493-87bd-dc696e54958c-S0/frameworks/af6eac18-a7d2-4493-87bd-dc696e54958c-0000/executors/executor-2/runs/5876d563-1b82-4fa9-b4b9-34deb50dcac0' to user 'mesos' I0410 20:49:10.972369 24431 slave.cpp:6892] Launching executor 'executor-2' of framework af6eac18-a7d2-4493-87bd-dc696e54958c-0000 with resources {} in work directory '/tmp/MasterTest_MultipleExecutors_nfBjg0/slaves/af6eac18-a7d2-4493-87bd-dc696e54958c-S0/frameworks/af6eac18-a7d2-4493-87bd-dc696e54958c-0000/executors/executor-2/runs/5876d563-1b82-4fa9-b4b9-34deb50dcac0' *** Aborted at 1491857350 (unix time) try "date -d @1491857350" if you are using GNU date *** I0410 20:49:10.972695 24432 exec.cpp:162] Version: 1.3.0 I0410 20:49:10.972745 24422 exec.cpp:212] Executor started at: executor(121)@172.17.0.2:60871 with pid 24418 PC: @ 0x7f4856bb20cd __GI_getenv *** SIGSEGV (@0xf0) received by PID 24418 (TID 0x7f484ae38700) from PID 240; stack trace: *** @ 0x7f485776b370 (unknown) @ 0x7f4856bb20cd __GI_getenv @ 0x7f485b356014 mesos::internal::slave::executorEnvironment() @ 0x7f485b37aff7 mesos::internal::slave::Slave::launchExecutor() @ 0x7f485b37fbd1 mesos::internal::slave::Slave::__run() @ 0x7f485a5ee391 process::ProcessManager::resume() @ 0x7f485a5f7427 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x7f4857508230 (unknown) @ 0x7f4857763dc5 start_thread @ 0x7f4856c7173d __clone make[3]: *** [CMakeFiles/check] Segmentation fault make[3]: Leaving directory `/mesos/build' make[2]: *** [CMakeFiles/check.dir/all] Error 2 make[2]: Leaving directory `/mesos/build' make[1]: *** [CMakeFiles/check.dir/rule] Error 2 make[1]: Leaving directory `/mesos/build' make: *** [check] Error 2 + docker rmi mesos-1491854890-30014 Untagged: mesos-1491854890-30014:latest Deleted: sha256:058b40d10d8aa482407db07fa634c0d2caf08555e0d09a2a89d83308e29ad0fc Deleted: sha256:5e6e4f394df5dcc7ce9b840be4b2225a66c5db10db05b2ccfba8c1e4e017d0f9 Deleted: sha256:9e8d6d031659d0f78d609782d8c908dc8686a914145920bdbe12e45560f2bf86 Deleted: sha256:b448542ded996a3beed0d5bbcbe7af33a93da7870e339a42ced3e1a652b519fb Deleted: sha256:9e613cb8b77a9d858d54d6a660b51813518d20459ecb78fdb8a62297856ecf44 Deleted: sha256:9307dbb60fc7d9fce225da7e8ebb41809f2c448ef9c43843cc29f7bbeed2f91c Deleted: sha256:75d98b1c1fbe83f74098b6bdf65fcad2aee9bf06e5fa05926f0d5e772e47776d Deleted: sha256:ece5b21387fd228453117e05616eed1a4c93f290aa198012529a8bd63b12afd3 Deleted: sha256:087a70dd7c07cc5ec895f948a18c214d1e58ca466964fd1ffd48a6e842aec8bd Deleted: sha256:d083fe21388cd25b36111bada2774461356d31d551e3df53166a3658aaee3788 Deleted: sha256:13c77f3029db4fe2822ea4cac151526b6853c202f5e69bf10c96d52fac35568f Deleted: sha256:51c674892dfed66b86502fa7d112b857f18e09bf3116b8af1be2d1a81b709e03 Deleted: sha256:17d50b1e04981c87f441625fb97c22b2c84fcc4a8e50effcbb194147d051eac9 Deleted: sha256:277d73b0c2d9dc0ed28ba6e17ee76939995e91724fe5d03a01968d5e47623720 Deleted: sha256:5f3518486224bea25c1fc414472a199ee0f5eded6338050c2094abc31d975b8f Deleted: sha256:d2485914f00b908738fadb87c998c2ad3f55cba951c7a22f2abf4363765d5901 Deleted: sha256:e233a77c29f76153c7923d8ac6d1b45c678e25724dad1cbfff72c8797abf3771 Deleted: sha256:4d6d4d784fb79945f8d937a429ee2289fd5a553d8ad025d47c630977cd96c58d Deleted: sha256:05019b61badd11e4d2d8f0ff9c5de8335dc9e11612b287a515a766063b2b9ef5 Deleted: sha256:7fb0594b4c280948db0328191fdb3b9ca87fe7db31efacea91c086993f5b10f7 Deleted: sha256:6ea5cf772aac4eb92c661871125c6f8c21b1890af8b79cfdcfa08d39432fe7c0 Deleted: sha256:b8e3332e500429a9b9b380f58614a8e2d3ff6c88d126104819a96028fb1ea06b Deleted: sha256:13ec6ce739de57712a01ef3f5264d3cc84c578e7b6413a84a4198ae09a3e6af7 Deleted: sha256:f0939684d33aa46162cee405a9467330b555dd1f118cbed2c417bd0ad39454b4 Deleted: sha256:e93427b2c9e2a60dbadc8ae2ccb6c3020bfbc3a879ca8dee26056fcd37248010 Build step 'Execute shell' marked build as failure
