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=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3781/display/redirect?page=changes>
Changes: [neil.conway] Fixed typos. ------------------------------------------ [...truncated 21.00 MB...] I0610 22:16:29.450922 4533 slave.cpp:3545] Status update manager successfully handled status update acknowledgement (UUID: 8a6aed7f-ab83-4603-ae62-940cf96ce1ea) for task 1 of framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:29.450979 4533 slave.cpp:7455] Completing task 1 I0610 22:16:30.340776 4528 hierarchical.cpp:2001] No inverse offers to send out! I0610 22:16:30.340868 4528 hierarchical.cpp:1493] Performed allocation for 1 agents in 1.164865ms I0610 22:16:30.341619 4528 master.cpp:7295] Sending 1 offers to framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 (default) at [email protected]:40875 I0610 22:16:30.342092 4528 sched.cpp:933] Scheduler::resourceOffers took 24011ns I0610 22:16:31.342689 4533 hierarchical.cpp:1911] No allocations performed I0610 22:16:31.342793 4533 hierarchical.cpp:2001] No inverse offers to send out! I0610 22:16:31.342850 4533 hierarchical.cpp:1493] Performed allocation for 1 agents in 372752ns I0610 22:16:32.345279 4529 hierarchical.cpp:1911] No allocations performed I0610 22:16:32.345402 4529 hierarchical.cpp:2001] No inverse offers to send out! I0610 22:16:32.345511 4529 hierarchical.cpp:1493] Performed allocation for 1 agents in 695064ns I0610 22:16:33.347401 4529 hierarchical.cpp:1911] No allocations performed I0610 22:16:33.347512 4529 hierarchical.cpp:2001] No inverse offers to send out! I0610 22:16:33.347584 4529 hierarchical.cpp:1493] Performed allocation for 1 agents in 398630ns I0610 22:16:34.349082 4532 hierarchical.cpp:1911] No allocations performed I0610 22:16:34.349205 4532 hierarchical.cpp:2001] No inverse offers to send out! I0610 22:16:34.349261 4532 hierarchical.cpp:1493] Performed allocation for 1 agents in 405859ns I0610 22:16:34.449604 4527 slave.cpp:5663] Killing executor 'default' of framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 at executor(134)@172.17.0.3:40875 I0610 22:16:34.450498 4533 slave.cpp:5268] Executor 'default' of framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 exited with status 0 I0610 22:16:34.450691 4533 slave.cpp:5368] Cleaning up executor 'default' of framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 at executor(134)@172.17.0.3:40875 I0610 22:16:34.451185 4533 slave.cpp:5464] Cleaning up framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.451658 4533 master.cpp:6606] Executor 'default' of framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 on agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 at slave(524)@172.17.0.3:40875 (5d87bac8c869): exited with status 0 I0610 22:16:34.451741 4533 master.cpp:8679] Removing executor 'default' with resources {} of framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 on agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 at slave(524)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.452051 4533 gc.cpp:55] Scheduling '/tmp/SlaveTest_KillTaskUnregisteredExecutor_hyHm6C/slaves/a30452ec-5e6a-40b0-8726-c46b63d985bf-S0/frameworks/a30452ec-5e6a-40b0-8726-c46b63d985bf-0000/executors/default/runs/80815e14-72f3-4786-979b-f6afd331b361' for gc 6.99999478117926days in the future I0610 22:16:34.452240 4533 gc.cpp:55] Scheduling '/tmp/SlaveTest_KillTaskUnregisteredExecutor_hyHm6C/slaves/a30452ec-5e6a-40b0-8726-c46b63d985bf-S0/frameworks/a30452ec-5e6a-40b0-8726-c46b63d985bf-0000/executors/default' for gc 6.99999477896days in the future I0610 22:16:34.452383 4533 gc.cpp:55] Scheduling '/tmp/SlaveTest_KillTaskUnregisteredExecutor_hyHm6C/slaves/a30452ec-5e6a-40b0-8726-c46b63d985bf-S0/frameworks/a30452ec-5e6a-40b0-8726-c46b63d985bf-0000' for gc 6.99999477666667days in the future I0610 22:16:34.452510 4533 status_update_manager.cpp:285] Closing status update streams for framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.452699 4533 sched.cpp:1143] Executor default on agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 exited with status 0 I0610 22:16:34.452810 4533 sched.cpp:1154] Scheduler::executorLost took 68887ns I0610 22:16:34.453181 4508 sched.cpp:2021] Asked to stop the driver I0610 22:16:34.453321 4533 sched.cpp:1203] Stopping framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.453606 4527 master.cpp:7976] Processing TEARDOWN call for framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 (default) at [email protected]:40875 I0610 22:16:34.453642 4527 master.cpp:7988] Removing framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 (default) at [email protected]:40875 I0610 22:16:34.453657 4527 master.cpp:3200] Deactivating framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 (default) at [email protected]:40875 I0610 22:16:34.453814 4528 hierarchical.cpp:410] Deactivated framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.454455 4532 slave.cpp:3098] Asked to shut down framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 by [email protected]:40875 I0610 22:16:34.454486 4532 slave.cpp:3113] Cannot shut down unknown framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.454809 4530 hierarchical.cpp:1177] 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 a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 from framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.455338 4530 hierarchical.cpp:353] Removed framework a30452ec-5e6a-40b0-8726-c46b63d985bf-0000 I0610 22:16:34.455756 4529 slave.cpp:817] Agent terminating I0610 22:16:34.456017 4529 master.cpp:1314] Agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 at slave(524)@172.17.0.3:40875 (5d87bac8c869) disconnected I0610 22:16:34.456049 4529 master.cpp:3237] Disconnecting agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 at slave(524)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.456104 4529 master.cpp:3256] Deactivating agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 at slave(524)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.457582 4529 hierarchical.cpp:715] Agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 deactivated I0610 22:16:34.458745 4508 master.cpp:1156] Master terminating I0610 22:16:34.459944 4529 hierarchical.cpp:620] Removed agent a30452ec-5e6a-40b0-8726-c46b63d985bf-S0 [ OK ] SlaveTest.KillTaskUnregisteredExecutor (5137 ms) [ RUN ] SlaveTest.KillTaskUnregisteredHTTPExecutor I0610 22:16:34.467116 4508 cluster.cpp:162] Creating default 'local' authorizer I0610 22:16:34.473332 4533 master.cpp:436] Master c730fad8-0a7d-410b-b9d3-7607b0f287a2 (5d87bac8c869) started on 172.17.0.3:40875 I0610 22:16:34.473708 4533 master.cpp:438] 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/ubpT7K/credentials" --filter_gpu_resources="true" --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.4.0/_inst/share/mesos/webui" --work_dir="/tmp/ubpT7K/master" --zk_session_timeout="10secs" I0610 22:16:34.474328 4533 master.cpp:488] Master only allowing authenticated frameworks to register I0610 22:16:34.474566 4533 master.cpp:502] Master only allowing authenticated agents to register I0610 22:16:34.474778 4533 master.cpp:515] Master only allowing authenticated HTTP frameworks to register I0610 22:16:34.474990 4533 credentials.hpp:37] Loading credentials for authentication from '/tmp/ubpT7K/credentials' I0610 22:16:34.475541 4533 master.cpp:560] Using default 'crammd5' authenticator I0610 22:16:34.475963 4533 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0610 22:16:34.476346 4533 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0610 22:16:34.476707 4533 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0610 22:16:34.477018 4533 master.cpp:640] Authorization enabled I0610 22:16:34.478338 4529 whitelist_watcher.cpp:77] No whitelist given I0610 22:16:34.478497 4531 hierarchical.cpp:169] Initialized hierarchical allocator process I0610 22:16:34.481580 4532 master.cpp:2159] Elected as the leading master! I0610 22:16:34.481624 4532 master.cpp:1698] Recovering from registrar I0610 22:16:34.481932 4527 registrar.cpp:345] Recovering registrar I0610 22:16:34.483081 4531 registrar.cpp:389] Successfully fetched the registry (0B) in 881152ns I0610 22:16:34.483472 4531 registrar.cpp:493] Applied 1 operations in 41117ns; attempting to update the registry I0610 22:16:34.484825 4531 registrar.cpp:550] Successfully updated the registry in 820736ns I0610 22:16:34.485107 4531 registrar.cpp:422] Successfully recovered registrar I0610 22:16:34.485685 4531 master.cpp:1797] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0610 22:16:34.485872 4532 hierarchical.cpp:207] Skipping recovery of hierarchical allocator: nothing to recover I0610 22:16:34.492808 4508 cluster.cpp:448] Creating default 'local' authorizer I0610 22:16:34.495072 4529 slave.cpp:248] Mesos agent started on (525)@172.17.0.3:40875 I0610 22:16:34.495112 4529 slave.cpp:249] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/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/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/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/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/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/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.4.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/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF" --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/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd" I0610 22:16:34.495479 4529 credentials.hpp:86] Loading credential for authentication from '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/credential' I0610 22:16:34.495714 4529 slave.cpp:281] Agent using credential for: test-principal I0610 22:16:34.495746 4529 credentials.hpp:37] Loading credentials for authentication from '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_EQBQOF/http_credentials' I0610 22:16:34.495931 4508 scheduler.cpp:184] Version: 1.4.0 I0610 22:16:34.495987 4529 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0610 22:16:34.496189 4529 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0610 22:16:34.497081 4534 scheduler.cpp:470] New master detected at [email protected]:40875 I0610 22:16:34.497269 4534 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0610 22:16:34.497717 4529 slave.cpp:552] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0610 22:16:34.498347 4529 slave.cpp:560] Agent attributes: [ ] I0610 22:16:34.498368 4529 slave.cpp:565] Agent hostname: 5d87bac8c869 I0610 22:16:34.498602 4531 status_update_manager.cpp:177] Pausing sending status updates I0610 22:16:34.501806 4532 state.cpp:62] Recovering state from '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd/meta' I0610 22:16:34.502355 4532 status_update_manager.cpp:203] Recovering status update manager I0610 22:16:34.502954 4530 slave.cpp:6127] Finished recovery I0610 22:16:34.504333 4530 slave.cpp:6309] Querying resource estimator for oversubscribable resources I0610 22:16:34.504684 4530 slave.cpp:945] New master detected at [email protected]:40875 I0610 22:16:34.504694 4531 status_update_manager.cpp:177] Pausing sending status updates I0610 22:16:34.504838 4530 slave.cpp:980] Detecting new master I0610 22:16:34.505167 4530 slave.cpp:6323] Received oversubscribable resources {} from the resource estimator I0610 22:16:34.508589 4533 scheduler.cpp:361] Connected with the master at http://172.17.0.3:40875/master/api/v1/scheduler I0610 22:16:34.511133 4528 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:40875/master/api/v1/scheduler I0610 22:16:34.512001 4528 slave.cpp:1007] Authenticating with master [email protected]:40875 I0610 22:16:34.512084 4528 slave.cpp:1018] Using default CRAM-MD5 authenticatee I0610 22:16:34.512521 4527 authenticatee.cpp:121] Creating new client SASL connection I0610 22:16:34.513217 4527 master.cpp:7465] Authenticating slave(525)@172.17.0.3:40875 I0610 22:16:34.513610 4528 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1062)@172.17.0.3:40875 I0610 22:16:34.513870 4527 authenticator.cpp:98] Creating new server SASL connection I0610 22:16:34.514277 4532 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0610 22:16:34.514318 4532 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0610 22:16:34.514502 4532 authenticator.cpp:204] Received SASL authentication start I0610 22:16:34.514607 4532 authenticator.cpp:326] Authentication requires more steps I0610 22:16:34.514801 4532 authenticatee.cpp:259] Received SASL authentication step I0610 22:16:34.514925 4532 authenticator.cpp:232] Received SASL authentication step I0610 22:16:34.514977 4532 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5d87bac8c869' server FQDN: '5d87bac8c869' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0610 22:16:34.515053 4532 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0610 22:16:34.515283 4532 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0610 22:16:34.515507 4532 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5d87bac8c869' server FQDN: '5d87bac8c869' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0610 22:16:34.515537 4532 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0610 22:16:34.515544 4532 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0610 22:16:34.516278 4532 authenticator.cpp:318] Authentication success I0610 22:16:34.516566 4531 authenticatee.cpp:299] Authentication success I0610 22:16:34.516597 4528 master.cpp:7495] Successfully authenticated principal 'test-principal' at slave(525)@172.17.0.3:40875 I0610 22:16:34.516717 4528 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1062)@172.17.0.3:40875 I0610 22:16:34.518204 4532 slave.cpp:1102] Successfully authenticated with master [email protected]:40875 I0610 22:16:34.518580 4532 slave.cpp:1522] Will retry registration in 9.037772ms if necessary I0610 22:16:34.518856 4527 master.cpp:5467] Received register agent message from slave(525)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.519019 4527 master.cpp:3699] Authorizing agent with principal 'test-principal' I0610 22:16:34.519326 4534 process.cpp:3778] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0610 22:16:34.520288 4534 master.cpp:5527] Authorized registration of agent at slave(525)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.520421 4534 master.cpp:5606] Registering agent at slave(525)@172.17.0.3:40875 (5d87bac8c869) with id c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 I0610 22:16:34.521025 4532 registrar.cpp:493] Applied 1 operations in 65400ns; attempting to update the registry I0610 22:16:34.521857 4532 registrar.cpp:550] Successfully updated the registry in 680192ns I0610 22:16:34.522456 4534 master.cpp:5653] Admitted agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.523587 4527 hierarchical.cpp:587] Added agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 (5d87bac8c869) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0610 22:16:34.523895 4527 hierarchical.cpp:1911] No allocations performed I0610 22:16:34.524171 4527 hierarchical.cpp:1493] Performed allocation for 1 agents in 389681ns I0610 22:16:34.524389 4527 slave.cpp:1148] Registered with master [email protected]:40875; given agent ID c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 I0610 22:16:34.524821 4527 slave.cpp:1168] Checkpointing SlaveInfo to '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd/meta/slaves/c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0/slave.info' I0610 22:16:34.523114 4534 master.cpp:5684] Registered agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0610 22:16:34.525334 4534 status_update_manager.cpp:184] Resuming sending status updates I0610 22:16:34.525449 4527 slave.cpp:1206] Forwarding total oversubscribed resources {} I0610 22:16:34.525563 4527 slave.cpp:4825] Received ping from slave-observer(502)@172.17.0.3:40875 I0610 22:16:34.525740 4527 master.cpp:6338] Received update of agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) with total oversubscribed resources {} I0610 22:16:34.528370 4530 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:33222 I0610 22:16:34.528836 4530 master.cpp:2511] Received subscription request for HTTP framework 'default' I0610 22:16:34.528964 4530 master.cpp:2195] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0610 22:16:34.529495 4530 master.cpp:2647] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I0610 22:16:34.530800 4530 hierarchical.cpp:301] Added framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.532047 4531 master.hpp:2202] Sending heartbeat to c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.532697 4530 hierarchical.cpp:2001] No inverse offers to send out! I0610 22:16:34.532755 4530 hierarchical.cpp:1493] Performed allocation for 1 agents in 1.784876ms I0610 22:16:34.533480 4531 master.cpp:7295] Sending 1 offers to framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 (default) I0610 22:16:34.536057 4527 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:40875/master/api/v1/scheduler I0610 22:16:34.539000 4533 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:40875/master/api/v1/scheduler I0610 22:16:34.541519 4527 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:40875/master/api/v1/scheduler I0610 22:16:34.544683 4528 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:40875/master/api/v1/scheduler I0610 22:16:34.548058 4531 process.cpp:3778] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0610 22:16:34.550752 4533 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:33220 I0610 22:16:34.552320 4533 master.cpp:3914] Processing ACCEPT call for offers: [ c730fad8-0a7d-410b-b9d3-7607b0f287a2-O0 ] on agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) for framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 (default) I0610 22:16:34.552517 4533 master.cpp:3466] Authorizing framework principal 'test-principal' to launch task 5c910145-a28b-40bf-9208-5ed4959b8152 I0610 22:16:34.553056 4533 master.cpp:3466] Authorizing framework principal 'test-principal' to launch task 87f7fcdc-4597-4935-9199-376b5341d590 I0610 22:16:34.559304 4533 master.cpp:9314] Adding task 5c910145-a28b-40bf-9208-5ed4959b8152 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.560142 4533 master.cpp:9314] Adding task 87f7fcdc-4597-4935-9199-376b5341d590 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 on agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.560505 4533 master.cpp:4774] Launching task group { 5c910145-a28b-40bf-9208-5ed4959b8152, 87f7fcdc-4597-4935-9199-376b5341d590 } of framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 (default) with resources cpus(*)(allocated: *):0.2; mem(*)(allocated: *):64; disk(*)(allocated: *):64 on agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 at slave(525)@172.17.0.3:40875 (5d87bac8c869) I0610 22:16:34.561336 4534 slave.cpp:1632] Got assigned task group containing tasks [ 5c910145-a28b-40bf-9208-5ed4959b8152, 87f7fcdc-4597-4935-9199-376b5341d590 ] for framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.562889 4534 slave.cpp:1913] Authorizing task group containing tasks [ 5c910145-a28b-40bf-9208-5ed4959b8152, 87f7fcdc-4597-4935-9199-376b5341d590 ] for framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.563117 4534 slave.cpp:6626] Authorizing framework principal 'test-principal' to launch task 5c910145-a28b-40bf-9208-5ed4959b8152 I0610 22:16:34.564169 4534 slave.cpp:6626] Authorizing framework principal 'test-principal' to launch task 87f7fcdc-4597-4935-9199-376b5341d590 I0610 22:16:34.565809 4534 slave.cpp:2100] Launching task group containing tasks [ 5c910145-a28b-40bf-9208-5ed4959b8152, 87f7fcdc-4597-4935-9199-376b5341d590 ] for framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.567283 4531 hierarchical.cpp:1177] Recovered cpus(*)(allocated: *):1.7; mem(*)(allocated: *):928; disk(*)(allocated: *):928; ports(*)(allocated: *):[31000-32000] (total: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000], allocated: cpus(*)(allocated: *):0.3; mem(*)(allocated: *):96; disk(*)(allocated: *):96) on agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 from framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.568012 4531 hierarchical.cpp:1214] Framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 filtered agent c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0 for 5secs I0610 22:16:34.568344 4534 paths.cpp:573] Trying to chown '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd/slaves/c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0/frameworks/c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000/executors/default/runs/f7039f96-65ea-45ef-b564-f09eb1b7d710' to user 'mesos' I0610 22:16:34.568963 4534 slave.cpp:7086] Launching executor 'default' of framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 with resources cpus(*)(allocated: *):0.1; mem(*)(allocated: *):32; disk(*)(allocated: *):32 in work directory '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd/slaves/c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0/frameworks/c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000/executors/default/runs/f7039f96-65ea-45ef-b564-f09eb1b7d710' I0610 22:16:34.569828 4534 slave.cpp:2795] Launching container f7039f96-65ea-45ef-b564-f09eb1b7d710 for executor 'default' of framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.571024 4534 slave.cpp:2329] Queued task group containing tasks [ 5c910145-a28b-40bf-9208-5ed4959b8152, 87f7fcdc-4597-4935-9199-376b5341d590 ] for executor 'default' of framework c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000 I0610 22:16:34.571202 4534 slave.cpp:898] Successfully attached file '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd/slaves/c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0/frameworks/c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000/executors/default/runs/f7039f96-65ea-45ef-b564-f09eb1b7d710' I0610 22:16:34.571276 4534 slave.cpp:898] Successfully attached file '/tmp/SlaveTest_KillTaskUnregisteredHTTPExecutor_0S0ltd/slaves/c730fad8-0a7d-410b-b9d3-7607b0f287a2-S0/frameworks/c730fad8-0a7d-410b-b9d3-7607b0f287a2-0000/executors/default/runs/f7039f96-65ea-45ef-b564-f09eb1b7d710' *** Aborted at 1497132994 (unix time) try "date -d @1497132994" if you are using GNU date *** I0610 22:16:34.574260 4532 executor.cpp:192] Version: 1.4.0 PC: @ 0x2b573be7d82d (unknown) I0610 22:16:34.579210 4527 executor.cpp:410] Connected with the agent I0610 22:16:34.581621 4527 scheduler.cpp:243] Sending KILL call to http://172.17.0.3:40875/master/api/v1/scheduler *** SIGSEGV (@0xf0) received by PID 4508 (TID 0x2b57442dd700) from PID 240; stack trace: *** @ 0x2b57478ab417 (unknown) @ 0x2b57478af6f9 (unknown) @ 0x2b573bc34330 (unknown) @ 0x2b573be7d82d (unknown) @ 0x2b573be736f1 (unknown) @ 0x2b573beca88e (unknown) @ 0x55bb12c5aeb9 os::strerror() @ 0x55bb12c74f4f ErrnoError::ErrnoError() @ 0x55bb12c74f2b ErrnoError::ErrnoError() @ 0x2b573971c3a8 _ZZN7process2io8internal4readEiPvmENKUlvE_clEv @ 0x2b573971fdab _ZN7process8internal4LoopIZNS_2io8internal4readEiPvmEUlvE_ZNS3_4readEiS4_mEUlRK6OptionImEE0_S7_mE5startEv @ 0x2b573971f284 _ZN7process4loopIZNS_2io8internal4readEiPvmEUlvE_ZNS2_4readEiS3_mEUlRK6OptionImEE0_S6_NS_11ControlFlowImEEmEENS_6FutureIT3_EERKS5_INS_4UPIDEEOT_OT0_ @ 0x2b573971c6bc process::io::internal::read() @ 0x2b573971cc8b process::io::read() @ 0x2b5739776924 process::network::internal::PollSocketImpl::recv() @ 0x2b573981bb9a process::network::internal::SocketImpl::recv() @ 0x2b57396f393d process::network::internal::Socket<>::recv() @ 0x2b57396f009c process::http::internal::ConnectionProcess::read() @ 0x2b57396f0a5f process::http::internal::ConnectionProcess::_read() @ 0x2b57396f8835 _ZZN7process8dispatchINS_4http8internal17ConnectionProcessERKNS_6FutureISsEES5_EEvRKNS_3PIDIT_EEMS9_FvT0_ET1_ENKUlPNS_11ProcessBaseEE_clESI_ @ 0x2b5739701a02 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchINS0_4http8internal17ConnectionProcessERKNS0_6FutureISsEES9_EEvRKNS0_3PIDIT_EEMSD_FvT0_ET1_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_ @ 0x2b57397b767d std::function<>::operator()() @ 0x2b573979cad9 process::ProcessBase::visit() @ 0x2b57397a74ba process::DispatchEvent::visit() @ 0x55bb12c5c022 process::ProcessBase::serve() @ 0x2b5739798d9a process::ProcessManager::resume() @ 0x2b5739794f6e _ZZN7process14ProcessManager12init_threadsEvENKUt_clEv @ 0x2b57397a6bc6 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE @ 0x2b57397a6b1d _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEclEv @ 0x2b57397a6ab6 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x2b573b4b5a60 (unknown) @ 0x2b573bc2c184 start_thread make[4]: *** [check-local] Segmentation fault (core dumped) make[4]: Leaving directory `/mesos/mesos-1.4.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.4.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.4.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.4.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1497128796-28650 Untagged: mesos-1497128796-28650:latest Deleted: sha256:bd4500165450fc65ef6f6065265feb256faa22a7e63f1422853488f6e2efc322 Deleted: sha256:d7112da2b8033dbc3623c8c8eb7a1f32732e2948205bdd7087e51a917cc3cfa7 Deleted: sha256:97a820290ad1794118b9ba4710e6ebb030ba0fb0f30c37ee58670540764e3239 Deleted: sha256:0d2c6a172a9d39d587d48af959780b0c7121f2f4c9df26cc34feacfe733e10cf Deleted: sha256:7dc366e5294278071656383e3037ae79dc5163ceebb1df729bc4b09c685835f6 Deleted: sha256:0ed44f73ff43e2aae4fedf18ee05fe8ca496b8a8e909c0a901f12cad0384c2a7 Deleted: sha256:c694812462f0b02b85765875104dd7ace74916ef14eb25a2ebdfae483eb0fd5f Deleted: sha256:84b9cacc4a9afcd9fa005b6dd1721e0a85b5fe3a19c44404750eaf2a98432800 Deleted: sha256:7745aa35dc8eec111b38facddfe2b67908eea5ec610e400f7d53dcb529abdfd0 Deleted: sha256:b97bb3d35e2dcb894f7edc194a1ae52eb1dab83f6d8e9ba8223c2a0a40aed877 Deleted: sha256:625f6b3c3634c3c907d66b1bb78da5cb63c88f4fa915a995805bc2e9df979e6b Deleted: sha256:e813fcbbb0f7eded8d7dcee3c13b177ce588e79f90137768c11ded77e7609f1c Deleted: sha256:434a5c7da071f49a55f30512e7970d6a0a04d0a7eebff729cc456c8dcf1393d0 Deleted: sha256:fd1345f21840d8afddd6b60c6316e0acbece2538f392d4dff8fee9b037e35935 Deleted: sha256:57355294f101039a24b181034c660f8532d3cf373e16ffa918606fc5f023db86 Deleted: sha256:ad299a6b9c0081ad2f6a350ba92d84b978aeda34022bc25a4afac79240e86d7a Deleted: sha256:c9663cd5bd25c68015ea36fe631af98c915f54db2c07ab4a40d98ea8fe9c2c87 Deleted: sha256:05da4ae5b2c5aca2c40630838f1ed71b34c6ecd38bebc5ffb1e13fe0f33437b0 Deleted: sha256:8cb6cc796dac6daca24400c24b2991ecf18b344ef3c3a9fd5ac0e75ef000ae29 Deleted: sha256:49ecbbf0db3f4391ff5c967c34c87edd1f48198a33e59065655e4bf0292ee49a Deleted: sha256:042cc694f4b8ea84f1c035a881cee019dcd729a213851ec46ae102258236be64 Deleted: sha256:03a46b1f703c124b689880f844c7d8ef4b29068ff6eb1e88c7bdb23f947e4779 Deleted: sha256:c5ae5b7c97ff69119ebaf9fa627d96e77f7dd25ab90fce3c3e6d6a40b5218b56 Deleted: sha256:75ec9051590bd05b1f65cb3ef24fc62b78d8f44693d478a2f7d0169d4564f4f5 Build step 'Execute shell' marked build as failure Not sending mail to unregistered user [email protected] Not sending mail to unregistered user [email protected]
