See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,CONFIGURATION=--verbose%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=centos%3A7,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3752/display/redirect?page=changes>
Changes: [alexr] Removed an extra space in a log entry. ------------------------------------------ [...truncated 24.93 MB...] I0531 19:59:17.040246 1102 hierarchical.cpp:672] Agent bad4774a-b605-4622-a21b-6a82043bcf39-S0 deactivated I0531 19:59:17.041165 1091 master.cpp:1155] Master terminating I0531 19:59:17.041332 1105 hierarchical.cpp:577] Removed agent bad4774a-b605-4622-a21b-6a82043bcf39-S0 [ OK ] ContentType/SchedulerTest.KillTask/0 (123 ms) [ RUN ] ContentType/SchedulerTest.KillTask/1 I0531 19:59:17.044752 1091 cluster.cpp:162] Creating default 'local' authorizer I0531 19:59:17.045542 1097 master.cpp:436] Master a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d (beab3ec719a8) started on 172.17.0.2:53462 I0531 19:59:17.045598 1097 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/DOYA0q/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/DOYA0q/master" --zk_session_timeout="10secs" I0531 19:59:17.045727 1097 master.cpp:488] Master only allowing authenticated frameworks to register I0531 19:59:17.045737 1097 master.cpp:502] Master only allowing authenticated agents to register I0531 19:59:17.045743 1097 master.cpp:515] Master only allowing authenticated HTTP frameworks to register I0531 19:59:17.045752 1097 credentials.hpp:37] Loading credentials for authentication from '/tmp/DOYA0q/credentials' I0531 19:59:17.045869 1097 master.cpp:560] Using default 'crammd5' authenticator I0531 19:59:17.045913 1097 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0531 19:59:17.046000 1097 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0531 19:59:17.046057 1097 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0531 19:59:17.046097 1097 master.cpp:640] Authorization enabled I0531 19:59:17.046195 1100 hierarchical.cpp:165] Initialized hierarchical allocator process I0531 19:59:17.046205 1106 whitelist_watcher.cpp:77] No whitelist given I0531 19:59:17.046995 1097 master.cpp:2161] Elected as the leading master! I0531 19:59:17.047010 1097 master.cpp:1700] Recovering from registrar I0531 19:59:17.047081 1097 registrar.cpp:345] Recovering registrar I0531 19:59:17.047245 1097 registrar.cpp:389] Successfully fetched the registry (0B) in 129792ns I0531 19:59:17.047281 1097 registrar.cpp:493] Applied 1 operations in 5455ns; attempting to update the registry I0531 19:59:17.047446 1097 registrar.cpp:550] Successfully updated the registry in 150016ns I0531 19:59:17.047502 1097 registrar.cpp:422] Successfully recovered registrar I0531 19:59:17.047627 1100 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register I0531 19:59:17.047642 1102 hierarchical.cpp:204] Skipping recovery of hierarchical allocator: nothing to recover I0531 19:59:17.054708 1091 cluster.cpp:448] Creating default 'local' authorizer I0531 19:59:17.055121 1100 slave.cpp:232] Mesos agent started on (694)@172.17.0.2:53462 I0531 19:59:17.055135 1100 slave.cpp:233] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_executors="true" --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/ContentType_SchedulerTest_KillTask_1_Hzgz1m/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_reregistration_timeout="2secs" --executor_secret_key="/tmp/ContentType_SchedulerTest_KillTask_1_Hzgz1m/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_KillTask_1_Hzgz1m/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/ContentType_SchedulerTest_KillTask_1_Hzgz1m/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/ContentType_SchedulerTest_KillTask_1_Hzgz1m" --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/ContentType_SchedulerTest_KillTask_1_4nI40T" I0531 19:59:17.055305 1100 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_KillTask_1_Hzgz1m/credential' I0531 19:59:17.055356 1091 scheduler.cpp:184] Version: 1.4.0 I0531 19:59:17.055399 1100 slave.cpp:265] Agent using credential for: test-principal I0531 19:59:17.055413 1100 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_KillTask_1_Hzgz1m/http_credentials' I0531 19:59:17.055572 1100 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor' I0531 19:59:17.055590 1095 scheduler.cpp:470] New master detected at [email protected]:53462 I0531 19:59:17.055608 1100 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor' I0531 19:59:17.055655 1100 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0531 19:59:17.055682 1100 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly' I0531 19:59:17.055619 1095 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master I0531 19:59:17.055797 1100 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite' I0531 19:59:17.055881 1100 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite' I0531 19:59:17.056296 1095 scheduler.cpp:361] Connected with the master at http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.056289 1100 slave.cpp:536] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0531 19:59:17.056334 1100 slave.cpp:544] Agent attributes: [ ] I0531 19:59:17.056365 1100 slave.cpp:549] Agent hostname: beab3ec719a8 I0531 19:59:17.056435 1093 status_update_manager.cpp:177] Pausing sending status updates I0531 19:59:17.056777 1107 state.cpp:62] Recovering state from '/tmp/ContentType_SchedulerTest_KillTask_1_4nI40T/meta' I0531 19:59:17.056946 1104 status_update_manager.cpp:203] Recovering status update manager I0531 19:59:17.057309 1101 slave.cpp:6083] Finished recovery I0531 19:59:17.057458 1097 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.057673 1101 slave.cpp:6265] Querying resource estimator for oversubscribable resources I0531 19:59:17.057770 1101 slave.cpp:929] New master detected at [email protected]:53462 I0531 19:59:17.057811 1100 status_update_manager.cpp:177] Pausing sending status updates I0531 19:59:17.057879 1101 slave.cpp:964] Detecting new master I0531 19:59:17.057965 1101 slave.cpp:6279] Received oversubscribable resources {} from the resource estimator I0531 19:59:17.057992 1100 process.cpp:3778] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0531 19:59:17.058493 1093 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:52539 I0531 19:59:17.058635 1093 master.cpp:2513] Received subscription request for HTTP framework 'default' I0531 19:59:17.058662 1093 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }' I0531 19:59:17.058799 1095 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I0531 19:59:17.059058 1095 master.hpp:2194] Sending heartbeat to a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.059267 1105 hierarchical.cpp:292] Added framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.059321 1105 hierarchical.cpp:1861] No allocations performed I0531 19:59:17.059340 1105 hierarchical.cpp:1951] No inverse offers to send out! I0531 19:59:17.059351 1105 hierarchical.cpp:1445] Performed allocation for 0 agents in 35703ns I0531 19:59:17.059471 1094 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.059710 1094 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.062445 1101 slave.cpp:991] Authenticating with master [email protected]:53462 I0531 19:59:17.062470 1101 slave.cpp:1002] Using default CRAM-MD5 authenticatee I0531 19:59:17.062539 1100 authenticatee.cpp:121] Creating new client SASL connection I0531 19:59:17.062690 1094 master.cpp:7487] Authenticating slave(694)@172.17.0.2:53462 I0531 19:59:17.062752 1097 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1289)@172.17.0.2:53462 I0531 19:59:17.062830 1098 authenticator.cpp:98] Creating new server SASL connection I0531 19:59:17.062952 1097 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0531 19:59:17.062973 1097 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0531 19:59:17.063024 1106 authenticator.cpp:204] Received SASL authentication start I0531 19:59:17.063073 1106 authenticator.cpp:326] Authentication requires more steps I0531 19:59:17.063117 1106 authenticatee.cpp:259] Received SASL authentication step I0531 19:59:17.063185 1100 authenticator.cpp:232] Received SASL authentication step I0531 19:59:17.063207 1100 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'beab3ec719a8' server FQDN: 'beab3ec719a8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0531 19:59:17.063220 1100 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0531 19:59:17.063233 1100 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0531 19:59:17.063242 1100 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'beab3ec719a8' server FQDN: 'beab3ec719a8' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0531 19:59:17.063247 1100 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0531 19:59:17.063251 1100 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0531 19:59:17.063261 1100 authenticator.cpp:318] Authentication success I0531 19:59:17.063325 1103 authenticatee.cpp:299] Authentication success I0531 19:59:17.063357 1100 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1289)@172.17.0.2:53462 I0531 19:59:17.063356 1107 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(694)@172.17.0.2:53462 I0531 19:59:17.063479 1103 slave.cpp:1086] Successfully authenticated with master [email protected]:53462 I0531 19:59:17.063567 1103 slave.cpp:1506] Will retry registration in 15.054967ms if necessary I0531 19:59:17.063630 1107 master.cpp:5429] Received register agent message from slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.063691 1107 master.cpp:3659] Authorizing agent with principal 'test-principal' I0531 19:59:17.063812 1094 master.cpp:5489] Authorized registration of agent at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.063879 1094 master.cpp:5568] Registering agent at slave(694)@172.17.0.2:53462 (beab3ec719a8) with id a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 I0531 19:59:17.063998 1095 registrar.cpp:493] Applied 1 operations in 14091ns; attempting to update the registry I0531 19:59:17.064141 1095 registrar.cpp:550] Successfully updated the registry in 120832ns I0531 19:59:17.064254 1094 master.cpp:5615] Admitted agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.064393 1095 slave.cpp:4809] Received ping from slave-observer(625)@172.17.0.2:53462 I0531 19:59:17.064420 1094 master.cpp:5646] Registered agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] I0531 19:59:17.064450 1095 slave.cpp:1132] Registered with master [email protected]:53462; given agent ID a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 I0531 19:59:17.064489 1102 hierarchical.cpp:544] Added agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 (beab3ec719a8) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {}) I0531 19:59:17.064518 1105 status_update_manager.cpp:184] Resuming sending status updates I0531 19:59:17.064699 1095 slave.cpp:1152] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_KillTask_1_4nI40T/meta/slaves/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0/slave.info' I0531 19:59:17.064903 1095 slave.cpp:1190] Forwarding total oversubscribed resources {} I0531 19:59:17.064940 1102 hierarchical.cpp:1951] No inverse offers to send out! I0531 19:59:17.064961 1102 hierarchical.cpp:1445] Performed allocation for 1 agents in 246721ns I0531 19:59:17.065052 1095 master.cpp:7317] Sending 1 offers to framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.065415 1095 master.cpp:6336] Received update of agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) with total oversubscribed resources {} I0531 19:59:17.065991 1096 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.066875 1103 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.067497 1093 process.cpp:3778] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0531 19:59:17.067818 1105 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:52538 I0531 19:59:17.068331 1105 master.cpp:3875] Processing ACCEPT call for offers: [ a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-O0 ] on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) for framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.068367 1105 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 07b3ec39-9175-4ee7-9c71-1265b47768c3 W0531 19:59:17.069031 1096 validation.cpp:1284] Executor 'default' for task '07b3ec39-9175-4ee7-9c71-1265b47768c3' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases. W0531 19:59:17.069052 1096 validation.cpp:1296] Executor 'default' for task '07b3ec39-9175-4ee7-9c71-1265b47768c3' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases. I0531 19:59:17.069186 1096 master.cpp:9338] Adding task 07b3ec39-9175-4ee7-9c71-1265b47768c3 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.069288 1096 master.cpp:4531] Launching task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.069464 1099 slave.cpp:1616] Got assigned task '07b3ec39-9175-4ee7-9c71-1265b47768c3' for framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.069911 1099 slave.cpp:1897] Authorizing task '07b3ec39-9175-4ee7-9c71-1265b47768c3' for framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.069934 1099 slave.cpp:6702] Authorizing framework principal 'test-principal' to launch task 07b3ec39-9175-4ee7-9c71-1265b47768c3 I0531 19:59:17.069957 1101 hierarchical.cpp:869] Updated allocation of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-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] I0531 19:59:17.070286 1096 slave.cpp:2084] Launching task '07b3ec39-9175-4ee7-9c71-1265b47768c3' for framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.070726 1096 paths.cpp:573] Trying to chown '/tmp/ContentType_SchedulerTest_KillTask_1_4nI40T/slaves/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0/frameworks/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000/executors/default/runs/728e8c51-b646-436b-bd4d-a8d85092343b' to user 'mesos' I0531 19:59:17.070904 1096 slave.cpp:7042] Launching executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 with resources {} in work directory '/tmp/ContentType_SchedulerTest_KillTask_1_4nI40T/slaves/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0/frameworks/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000/executors/default/runs/728e8c51-b646-436b-bd4d-a8d85092343b' I0531 19:59:17.071154 1096 slave.cpp:2313] Queued task '07b3ec39-9175-4ee7-9c71-1265b47768c3' for executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.071187 1096 slave.cpp:882] Successfully attached file '/tmp/ContentType_SchedulerTest_KillTask_1_4nI40T/slaves/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0/frameworks/a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000/executors/default/runs/728e8c51-b646-436b-bd4d-a8d85092343b' I0531 19:59:17.071280 1096 slave.cpp:2779] Launching container 728e8c51-b646-436b-bd4d-a8d85092343b for executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.072146 1101 executor.cpp:192] Version: 1.4.0 I0531 19:59:17.072682 1095 executor.cpp:410] Connected with the agent I0531 19:59:17.072901 1093 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.073315 1094 process.cpp:3778] Handling HTTP event for process 'slave(694)' with path: '/slave(694)/api/v1/executor' I0531 19:59:17.074053 1095 http.cpp:1115] HTTP POST for /slave(694)/api/v1/executor from 172.17.0.2:52540 I0531 19:59:17.074120 1095 slave.cpp:3593] Received Subscribe request for HTTP executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.074467 1095 slave.cpp:2526] Sending queued task '07b3ec39-9175-4ee7-9c71-1265b47768c3' to executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (via HTTP) I0531 19:59:17.075050 1097 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.075425 1097 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.075716 1106 executor.cpp:307] Sending UPDATE call to http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.076071 1095 process.cpp:3778] Handling HTTP event for process 'slave(694)' with path: '/slave(694)/api/v1/executor' I0531 19:59:17.076653 1099 http.cpp:1115] HTTP POST for /slave(694)/api/v1/executor from 172.17.0.2:52541 I0531 19:59:17.076707 1099 slave.cpp:4279] Handling status update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.076922 1103 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.076947 1103 status_update_manager.cpp:500] Creating StatusUpdate stream for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.077112 1103 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 to the agent I0531 19:59:17.077195 1093 slave.cpp:4719] Forwarding the update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 to [email protected]:53462 I0531 19:59:17.077307 1093 slave.cpp:4613] Status update manager successfully handled status update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.077359 1105 master.cpp:6481] Status update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 from agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.077392 1105 master.cpp:6549] Forwarding status update TASK_RUNNING (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.077620 1105 master.cpp:8580] Updating the state of task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING) I0531 19:59:17.077641 1107 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.078092 1106 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.078500 1103 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.078646 1103 scheduler.cpp:243] Sending KILL call to http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.078899 1101 process.cpp:3778] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0531 19:59:17.118599 1107 process.cpp:3778] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I0531 19:59:17.118935 1107 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:52538 I0531 19:59:17.119141 1107 master.cpp:5194] Processing ACKNOWLEDGE call a90e9ceb-4fb5-4a82-a28d-6145fff19ce9 for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 I0531 19:59:17.119302 1107 status_update_manager.cpp:395] Received status update acknowledgement (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.119396 1092 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:52538 I0531 19:59:17.119407 1095 slave.cpp:3529] Status update manager successfully handled status update acknowledgement (UUID: a90e9ceb-4fb5-4a82-a28d-6145fff19ce9) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.119513 1092 master.cpp:5013] Processing KILL call for task '07b3ec39-9175-4ee7-9c71-1265b47768c3' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.119540 1092 master.cpp:5086] Telling agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) to kill task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.119693 1107 slave.cpp:2852] Asked to kill task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.120132 1106 executor.cpp:725] Enqueuing event KILL received from http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.120510 1099 executor.cpp:307] Sending UPDATE call to http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.120833 1101 process.cpp:3778] Handling HTTP event for process 'slave(694)' with path: '/slave(694)/api/v1/executor' I0531 19:59:17.159250 1097 http.cpp:1115] HTTP POST for /slave(694)/api/v1/executor from 172.17.0.2:52541 I0531 19:59:17.159385 1097 slave.cpp:4279] Handling status update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.160194 1097 status_update_manager.cpp:323] Received status update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.160269 1097 status_update_manager.cpp:377] Forwarding update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 to the agent I0531 19:59:17.160398 1097 slave.cpp:4719] Forwarding the update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 to [email protected]:53462 I0531 19:59:17.160497 1097 slave.cpp:4613] Status update manager successfully handled status update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.160665 1097 master.cpp:6481] Status update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 from agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.160703 1097 master.cpp:6549] Forwarding status update TASK_KILLED (UUID: 7c137288-c39b-4582-9d73-3299bf69d180) for task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.161001 1097 master.cpp:8580] Updating the state of task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0531 19:59:17.161519 1097 hierarchical.cpp:1133] 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 a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 from framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.161552 1099 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.161850 1099 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:53462/master/api/v1/scheduler I0531 19:59:17.162817 1097 master.cpp:1430] Framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) disconnected I0531 19:59:17.163036 1097 master.cpp:3160] Deactivating framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.163238 1097 master.cpp:3137] Disconnecting framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.163419 1097 master.cpp:1445] Giving framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) 0ns to failover I0531 19:59:17.163635 1097 hierarchical.cpp:393] Deactivated framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.163835 1097 master.cpp:7158] Framework failover timeout, removing framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.163992 1097 master.cpp:8012] Removing framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (default) I0531 19:59:17.164192 1097 master.cpp:8580] Updating the state of task 07b3ec39-9175-4ee7-9c71-1265b47768c3 of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED) I0531 19:59:17.164320 1097 master.cpp:8674] Removing task 07b3ec39-9175-4ee7-9c71-1265b47768c3 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.164510 1097 master.cpp:8703] Removing executor 'default' with resources {} of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) I0531 19:59:17.164682 1097 slave.cpp:3082] Asked to shut down framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 by [email protected]:53462 I0531 19:59:17.164701 1097 slave.cpp:3107] Shutting down framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.164712 1097 slave.cpp:5546] Shutting down executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (via HTTP) I0531 19:59:17.164858 1098 hierarchical.cpp:344] Removed framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 I0531 19:59:17.165364 1097 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.2:53462/slave(694)/api/v1/executor I0531 19:59:17.165745 1098 slave.cpp:5232] Executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 exited with status 0 I0531 19:59:17.165782 1098 slave.cpp:5332] Cleaning up executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 (via HTTP) I0531 19:59:17.165993 1098 slave.cpp:5420] Cleaning up framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 *** Aborted at 1496260757 (unix time) try "date -d @1496260757" if you are using GNU date *** PC: @ 0x1dce8bf testing::internal::UntypedFunctionMockerBase::SetOwnerAndName() *** SIGSEGV (@0x7fa3d7e36738) received by PID 1091 (TID 0x7fa3ccda4700) from PID 18446744073036588856; stack trace: *** @ 0x7fa3d4877370 (unknown) @ 0x1dce8bf testing::internal::UntypedFunctionMockerBase::SetOwnerAndName() @ 0xe58a8e mesos::internal::tests::executor::TestMesos<>::events() @ 0xe45ebd std::_Function_handler<>::_M_invoke() @ 0x7fa3d8f94bb5 process::AsyncExecutorProcess::execute<>() W0531 19:59:17.165993 1102 master.cpp:6604] Ignoring unknown exited executor 'default' of framework a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-0000 on agent a7dd7dae-3a1c-4f49-822a-10b5c5f0d70d-S0 at slave(694)@172.17.0.2:53462 (beab3ec719a8) @ 0x7fa3d8f9eeb5 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISC_SaISC_EEEEESG_SK_SG_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSR_FSO_T1_T2_ET3_T4_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_ @ 0x7fa3d7df96d1 process::ProcessManager::resume() @ 0x7fa3d7e03017 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv @ 0x7fa3d4614230 (unknown) @ 0x7fa3d486fdc5 start_thread @ 0x7fa3d3d7d76d __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-1496257286-10725 Untagged: mesos-1496257286-10725:latest Deleted: sha256:7409063a42b1cbf0fcdf154d7f4a8db05cc8bb1b46adcbe8e1a804716dd7c0b1 Deleted: sha256:e81913cd1490b7526c1d9b86499842ca1f85aff67271a57af011af0682fbcff1 Deleted: sha256:d5113c199970ef23ea3a237876fdb2dbfa8df5f62f0f88947018639ef581b6e0 Deleted: sha256:c9e4be88f18e3d94aec6ec9ae3b068c20883a80d7d4b3e53ff9008a65737d7d2 Deleted: sha256:f3d2a5af901df52105ad8c117f4682efacb15e908e6e9309e18c217cf388451b Deleted: sha256:3ad935ff400660d95b39951dbddb50ee3f567e7ab92766fdb0493ea4cd973089 Deleted: sha256:1663d36db5b2b5519ad9513bff8f026c66d1180c926aff24fe8002d3572440f0 Deleted: sha256:36ebb65c4878aeed423553411f6f58a2b783e8f76aa0fe0a22b142377f0a0a2d Deleted: sha256:54cc16bb031663b8f0b489ed10db778602030b85f4d2875bc785879a1e02dab6 Deleted: sha256:53f75f6e1cfff3c5afa59e2a6bf8b74e803e02b1dfcd5bbe184c479e8538adfa Deleted: sha256:a2033dd6780ddd234f3300753c1a380cfcd185252b63d66b7dbf0d5b8cd71bb6 Deleted: sha256:828f41a535adfbc57c032b2e22d6d11ab9cd34034cb7ccb403265f323030fdd2 Deleted: sha256:259b02ab6c2e776c744c9205585bbbaba454dd3e7748a14173edebefba0c53a2 Deleted: sha256:6b57e592cee52f432c33cde170b3d5daffa108e2eda8c08d7067a0c862445263 Deleted: sha256:62348ab0934093b038ec7ac028409f4f6d050f89dd89bcbfc774be6f48657f0b Deleted: sha256:f781d5c2d021d565d7504f417c63450c3214bf990def5ca07376691ee6ba7042 Deleted: sha256:bb41e6de3f35de77d443efb9d9c95fd7c7f853962d01e9cfb4f60eb0ddc7fa83 Deleted: sha256:9e1c709ac614d1df08e4a81c506ceac1016ef75102f86d0aeb4cc4ceadf25ec9 Deleted: sha256:f843fc1aaf61aa155a1f7982726416d95ab5093f3f4d449a97f8168f2a75ff62 Deleted: sha256:6aefef2726c1b8c1e76b4adc6415a6d4329ed7dd1b72b65a08012d011501a3ae Deleted: sha256:68bfb9715b0d431c016582c36eddc7dd1aecffed888c44513eeb8e51dbe4cbbb Deleted: sha256:830dd084e3920b2db628c03660140a6bc34547063bc99f2d482a2240382b2101 Deleted: sha256:a05128cb04d5576d52d1deae68d1dff5f99779f3c344f2bbede358333cdc4cd5 Deleted: sha256:509d3284bb12497c41f90280263b75ccc5f9f18ab24ac8b85ab165f7f70f690e Deleted: sha256:1121eae7e62186450c8fbbef743ebf876c141090438f08f7422b74abc2238f8b Build step 'Execute shell' marked build as failure
