You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2017/05/31 19:59:23 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3752

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 master@172.17.0.2: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 master@172.17.0.2: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 master@172.17.0.2: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 master@172.17.0.2: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 master@172.17.0.2: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 master@172.17.0.2: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 master@172.17.0.2: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 master@172.17.0.2: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

Jenkins build is back to normal : Mesos-Buildbot » cmake,gcc,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,centos:7,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3753

Posted by Apache Jenkins Server <je...@builds.apache.org>.
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)/3753/display/redirect?page=changes>