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/25 21:08:55 UTC

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

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=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3726/display/redirect?page=changes>

Changes:

[neil.conway] Removed two unused "using" statements.

[neil.conway] Fixed flakiness in MasterAllocatorTest.FrameworkExited.

------------------------------------------
[...truncated 25.31 MB...]
I0525 21:08:46.708437 27847 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_1_FHKylA/slaves/6aa9c024-0524-4a9e-831a-20e5d32d3feb-S0/frameworks/6aa9c024-0524-4a9e-831a-20e5d32d3feb-0000/executors/default/runs/56b589a0-ca90-41e6-be57-5fe994642a41' for gc 6.99999181080889days in the future
I0525 21:08:46.708549 27840 hierarchical.cpp:653] Agent 6aa9c024-0524-4a9e-831a-20e5d32d3feb-S0 deactivated
I0525 21:08:46.708545 27847 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_1_FHKylA/slaves/6aa9c024-0524-4a9e-831a-20e5d32d3feb-S0/frameworks/6aa9c024-0524-4a9e-831a-20e5d32d3feb-0000/executors/default' for gc 6.99999180391111days in the future
I0525 21:08:46.708608 27847 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_1_FHKylA/slaves/6aa9c024-0524-4a9e-831a-20e5d32d3feb-S0/frameworks/6aa9c024-0524-4a9e-831a-20e5d32d3feb-0000' for gc 6.99999180283556days in the future
I0525 21:08:46.709898 27850 master.cpp:1155] Master terminating
I0525 21:08:46.710177 27844 hierarchical.cpp:558] Removed agent 6aa9c024-0524-4a9e-831a-20e5d32d3feb-S0
[       OK ] ContentType/SchedulerTest.ReconcileTask/1 (92 ms)
[ RUN      ] ContentType/SchedulerTest.KillTask/0
I0525 21:08:46.714036 27839 cluster.cpp:162] Creating default 'local' authorizer
I0525 21:08:46.715005 27855 master.cpp:436] Master 7b02b418-609c-4ff8-b5ad-a40fa1f41b90 (0958260158b0) started on 172.17.0.3:55373
I0525 21:08:46.715029 27855 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/fhlflg/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/fhlflg/master" --zk_session_timeout="10secs"
I0525 21:08:46.715181 27855 master.cpp:488] Master only allowing authenticated frameworks to register
I0525 21:08:46.715194 27855 master.cpp:502] Master only allowing authenticated agents to register
I0525 21:08:46.715204 27855 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0525 21:08:46.715212 27855 credentials.hpp:37] Loading credentials for authentication from '/tmp/fhlflg/credentials'
I0525 21:08:46.715361 27855 master.cpp:560] Using default 'crammd5' authenticator
I0525 21:08:46.715417 27855 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0525 21:08:46.715459 27855 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0525 21:08:46.715489 27855 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0525 21:08:46.715514 27855 master.cpp:640] Authorization enabled
I0525 21:08:46.715581 27844 hierarchical.cpp:158] Initialized hierarchical allocator process
I0525 21:08:46.715673 27844 whitelist_watcher.cpp:77] No whitelist given
I0525 21:08:46.716374 27843 master.cpp:2161] Elected as the leading master!
I0525 21:08:46.716392 27843 master.cpp:1700] Recovering from registrar
I0525 21:08:46.716466 27855 registrar.cpp:345] Recovering registrar
I0525 21:08:46.716622 27855 registrar.cpp:389] Successfully fetched the registry (0B) in 135936ns
I0525 21:08:46.716656 27855 registrar.cpp:493] Applied 1 operations in 5888ns; attempting to update the registry
I0525 21:08:46.716835 27842 registrar.cpp:550] Successfully updated the registry in 123904ns
I0525 21:08:46.716907 27842 registrar.cpp:422] Successfully recovered registrar
I0525 21:08:46.717083 27841 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0525 21:08:46.717864 27851 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0525 21:08:46.720160 27839 cluster.cpp:448] Creating default 'local' authorizer
I0525 21:08:46.720723 27843 slave.cpp:225] Mesos agent started on (692)@172.17.0.3:55373
I0525 21:08:46.720743 27843 slave.cpp:226] 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_0_Xua7F6/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_0_Xua7F6/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_KillTask_0_Xua7F6/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_0_Xua7F6/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_0_Xua7F6" --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_0_wTFFvb"
I0525 21:08:46.721047 27843 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_KillTask_0_Xua7F6/credential'
I0525 21:08:46.721185 27843 slave.cpp:258] Agent using credential for: test-principal
I0525 21:08:46.721199 27843 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_KillTask_0_Xua7F6/http_credentials'
I0525 21:08:46.721344 27843 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0525 21:08:46.721398 27843 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0525 21:08:46.721463 27843 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0525 21:08:46.721487 27843 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0525 21:08:46.721556 27843 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0525 21:08:46.721593 27843 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0525 21:08:46.721987 27843 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0525 21:08:46.722023 27843 slave.cpp:537] Agent attributes: [  ]
I0525 21:08:46.722030 27843 slave.cpp:542] Agent hostname: 0958260158b0
I0525 21:08:46.722404 27843 status_update_manager.cpp:177] Pausing sending status updates
I0525 21:08:46.722626 27843 state.cpp:62] Recovering state from '/tmp/ContentType_SchedulerTest_KillTask_0_wTFFvb/meta'
I0525 21:08:46.722774 27843 status_update_manager.cpp:203] Recovering status update manager
I0525 21:08:46.722864 27843 slave.cpp:5976] Finished recovery
I0525 21:08:46.723247 27843 slave.cpp:6158] Querying resource estimator for oversubscribable resources
I0525 21:08:46.723381 27843 slave.cpp:922] New master detected at master@172.17.0.3:55373
I0525 21:08:46.723435 27843 slave.cpp:957] Detecting new master
I0525 21:08:46.723485 27843 slave.cpp:6172] Received oversubscribable resources {} from the resource estimator
I0525 21:08:46.723532 27843 status_update_manager.cpp:177] Pausing sending status updates
I0525 21:08:46.721050 27839 scheduler.cpp:184] Version: 1.4.0
I0525 21:08:46.723953 27850 scheduler.cpp:470] New master detected at master@172.17.0.3:55373
I0525 21:08:46.723973 27850 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0525 21:08:46.724556 27850 scheduler.cpp:361] Connected with the master at http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.725344 27847 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.725916 27841 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0525 21:08:46.726347 27846 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:41251
I0525 21:08:46.726425 27846 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0525 21:08:46.726459 27846 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0525 21:08:46.726672 27851 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [  ]
I0525 21:08:46.726956 27850 hierarchical.cpp:273] Added framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.726991 27851 master.hpp:2194] Sending heartbeat to 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.727001 27850 hierarchical.cpp:1854] No allocations performed
I0525 21:08:46.727049 27850 hierarchical.cpp:1944] No inverse offers to send out!
I0525 21:08:46.727075 27850 hierarchical.cpp:1438] Performed allocation for 0 agents in 80276ns
I0525 21:08:46.727447 27840 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.727618 27840 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.731469 27843 slave.cpp:984] Authenticating with master master@172.17.0.3:55373
I0525 21:08:46.731528 27843 slave.cpp:995] Using default CRAM-MD5 authenticatee
I0525 21:08:46.731675 27854 authenticatee.cpp:121] Creating new client SASL connection
I0525 21:08:46.731916 27855 master.cpp:7487] Authenticating slave(692)@172.17.0.3:55373
I0525 21:08:46.731972 27843 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1284)@172.17.0.3:55373
I0525 21:08:46.732107 27853 authenticator.cpp:98] Creating new server SASL connection
I0525 21:08:46.732249 27853 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0525 21:08:46.732266 27853 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0525 21:08:46.732311 27853 authenticator.cpp:204] Received SASL authentication start
I0525 21:08:46.732367 27853 authenticator.cpp:326] Authentication requires more steps
I0525 21:08:46.732434 27842 authenticatee.cpp:259] Received SASL authentication step
I0525 21:08:46.732486 27842 authenticator.cpp:232] Received SASL authentication step
I0525 21:08:46.732506 27842 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0958260158b0' server FQDN: '0958260158b0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I0525 21:08:46.732514 27842 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0525 21:08:46.732524 27842 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0525 21:08:46.732532 27842 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '0958260158b0' server FQDN: '0958260158b0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I0525 21:08:46.732537 27842 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0525 21:08:46.732542 27842 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0525 21:08:46.732551 27842 authenticator.cpp:318] Authentication success
I0525 21:08:46.732594 27854 authenticatee.cpp:299] Authentication success
I0525 21:08:46.732638 27842 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1284)@172.17.0.3:55373
I0525 21:08:46.732636 27852 master.cpp:7517] Successfully authenticated principal 'test-principal' at slave(692)@172.17.0.3:55373
I0525 21:08:46.732725 27854 slave.cpp:1079] Successfully authenticated with master master@172.17.0.3:55373
I0525 21:08:46.732801 27854 slave.cpp:1507] Will retry registration in 3.117085ms if necessary
I0525 21:08:46.732851 27853 master.cpp:5429] Received register agent message from slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.732897 27853 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0525 21:08:46.733042 27854 master.cpp:5489] Authorized registration of agent at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.733096 27854 master.cpp:5568] Registering agent at slave(692)@172.17.0.3:55373 (0958260158b0) with id 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0
I0525 21:08:46.733238 27853 registrar.cpp:493] Applied 1 operations in 19236ns; attempting to update the registry
I0525 21:08:46.733405 27853 registrar.cpp:550] Successfully updated the registry in 144128ns
I0525 21:08:46.733494 27843 master.cpp:5615] Admitted agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.733705 27852 slave.cpp:4751] Received ping from slave-observer(623)@172.17.0.3:55373
I0525 21:08:46.733731 27843 master.cpp:5646] Registered agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0525 21:08:46.733796 27852 slave.cpp:1125] Registered with master master@172.17.0.3:55373; given agent ID 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0
I0525 21:08:46.733831 27852 fetcher.cpp:94] Clearing fetcher cache
I0525 21:08:46.733902 27843 hierarchical.cpp:525] Added agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 (0958260158b0) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0525 21:08:46.734197 27852 slave.cpp:1153] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_KillTask_0_wTFFvb/meta/slaves/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0/slave.info'
I0525 21:08:46.734282 27843 hierarchical.cpp:1944] No inverse offers to send out!
I0525 21:08:46.734303 27843 hierarchical.cpp:1438] Performed allocation for 1 agents in 333341ns
I0525 21:08:46.734351 27843 status_update_manager.cpp:184] Resuming sending status updates
I0525 21:08:46.734529 27852 slave.cpp:1191] Forwarding total oversubscribed resources {}
I0525 21:08:46.734547 27843 master.cpp:7317] Sending 1 offers to framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.734767 27843 master.cpp:6336] Received update of agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0) with total oversubscribed resources {}
I0525 21:08:46.735266 27848 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.736330 27845 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.736868 27848 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0525 21:08:46.737332 27841 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:41250
I0525 21:08:46.737648 27841 master.cpp:3875] Processing ACCEPT call for offers: [ 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-O0 ] on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0) for framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.737696 27841 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task e8c0bd21-974a-4cc6-beea-95ecce0d5074
W0525 21:08:46.738510 27841 validation.cpp:1284] Executor 'default' for task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0525 21:08:46.738541 27841 validation.cpp:1296] Executor 'default' for task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0525 21:08:46.738703 27841 master.cpp:9338] Adding task e8c0bd21-974a-4cc6-beea-95ecce0d5074 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.738795 27841 master.cpp:4531] Launching task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.739014 27843 slave.cpp:1617] Got assigned task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' for framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.739320 27843 slave.cpp:1898] Authorizing task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' for framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.739351 27843 slave.cpp:6595] Authorizing framework principal 'test-principal' to launch task e8c0bd21-974a-4cc6-beea-95ecce0d5074
I0525 21:08:46.739646 27854 hierarchical.cpp:850] Updated allocation of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-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]
I0525 21:08:46.739768 27855 slave.cpp:2085] Launching task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' for framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.740401 27855 paths.cpp:573] Trying to chown '/tmp/ContentType_SchedulerTest_KillTask_0_wTFFvb/slaves/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0/frameworks/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000/executors/default/runs/264908d7-ef63-4d74-8ba6-acce7cc669b3' to user 'mesos'
I0525 21:08:46.740597 27855 slave.cpp:6935] Launching executor 'default' of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 with resources {} in work directory '/tmp/ContentType_SchedulerTest_KillTask_0_wTFFvb/slaves/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0/frameworks/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000/executors/default/runs/264908d7-ef63-4d74-8ba6-acce7cc669b3'
I0525 21:08:46.740900 27855 slave.cpp:2314] Queued task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' for executor 'default' of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.740947 27855 slave.cpp:875] Successfully attached file '/tmp/ContentType_SchedulerTest_KillTask_0_wTFFvb/slaves/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0/frameworks/7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000/executors/default/runs/264908d7-ef63-4d74-8ba6-acce7cc669b3'
I0525 21:08:46.742118 27855 executor.cpp:192] Version: 1.4.0
I0525 21:08:46.742878 27853 executor.cpp:410] Connected with the agent
I0525 21:08:46.743223 27842 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.743706 27841 process.cpp:3730] Handling HTTP event for process 'slave(692)' with path: '/slave(692)/api/v1/executor'
I0525 21:08:46.744593 27849 http.cpp:1115] HTTP POST for /slave(692)/api/v1/executor from 172.17.0.3:41252
I0525 21:08:46.744688 27849 slave.cpp:3572] Received Subscribe request for HTTP executor 'default' of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.745126 27849 slave.cpp:2527] Sending queued task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' to executor 'default' of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (via HTTP)
I0525 21:08:46.745820 27841 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.746191 27844 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.746671 27853 executor.cpp:307] Sending UPDATE call to http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.747128 27853 process.cpp:3730] Handling HTTP event for process 'slave(692)' with path: '/slave(692)/api/v1/executor'
I0525 21:08:46.748026 27842 http.cpp:1115] HTTP POST for /slave(692)/api/v1/executor from 172.17.0.3:41253
I0525 21:08:46.748103 27842 slave.cpp:4221] Handling status update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.748482 27853 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.748535 27853 status_update_manager.cpp:500] Creating StatusUpdate stream for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.748771 27853 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 to the agent
I0525 21:08:46.748896 27840 slave.cpp:4661] Forwarding the update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 to master@172.17.0.3:55373
I0525 21:08:46.749028 27840 slave.cpp:4555] Status update manager successfully handled status update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.749088 27847 master.cpp:6481] Status update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 from agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.749122 27847 master.cpp:6549] Forwarding status update TASK_RUNNING (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.749267 27847 master.cpp:8580] Updating the state of task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0525 21:08:46.749737 27840 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.749774 27841 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.750319 27845 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.750439 27845 scheduler.cpp:243] Sending KILL call to http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.750730 27841 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0525 21:08:46.790017 27847 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0525 21:08:46.790386 27847 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:41250
I0525 21:08:46.790475 27847 master.cpp:5194] Processing ACKNOWLEDGE call 766d1da6-e24a-46f3-ab4c-7e0d48987f5c for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default) on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0
I0525 21:08:46.790691 27842 status_update_manager.cpp:395] Received status update acknowledgement (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.790783 27842 slave.cpp:3508] Status update manager successfully handled status update acknowledgement (UUID: 766d1da6-e24a-46f3-ab4c-7e0d48987f5c) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.790947 27853 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:41250
I0525 21:08:46.790997 27853 master.cpp:5013] Processing KILL call for task 'e8c0bd21-974a-4cc6-beea-95ecce0d5074' of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.791020 27853 master.cpp:5086] Telling agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0) to kill task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.791174 27853 slave.cpp:2831] Asked to kill task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.791616 27854 executor.cpp:725] Enqueuing event KILL received from http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.791888 27851 executor.cpp:307] Sending UPDATE call to http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.792250 27851 process.cpp:3730] Handling HTTP event for process 'slave(692)' with path: '/slave(692)/api/v1/executor'
I0525 21:08:46.830540 27851 http.cpp:1115] HTTP POST for /slave(692)/api/v1/executor from 172.17.0.3:41253
I0525 21:08:46.830655 27851 slave.cpp:4221] Handling status update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.831197 27850 status_update_manager.cpp:323] Received status update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.831269 27850 status_update_manager.cpp:377] Forwarding update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 to the agent
I0525 21:08:46.831398 27847 slave.cpp:4661] Forwarding the update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 to master@172.17.0.3:55373
I0525 21:08:46.831522 27847 slave.cpp:4555] Status update manager successfully handled status update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.831558 27850 master.cpp:6481] Status update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 from agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.831588 27850 master.cpp:6549] Forwarding status update TASK_KILLED (UUID: 8823e6e5-debf-41a1-b5fb-df8293e07ac1) for task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.831734 27850 master.cpp:8580] Updating the state of task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0525 21:08:46.832124 27844 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.3:55373/slave(692)/api/v1/executor
I0525 21:08:46.832392 27846 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.3:55373/master/api/v1/scheduler
I0525 21:08:46.832494 27841 hierarchical.cpp:1114] 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 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 from framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.833148 27841 master.cpp:1430] Framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default) disconnected
I0525 21:08:46.833166 27841 master.cpp:3160] Deactivating framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.833192 27841 master.cpp:3137] Disconnecting framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.833207 27841 master.cpp:1445] Giving framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default) 0ns to failover
I0525 21:08:46.833225 27852 hierarchical.cpp:374] Deactivated framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.833406 27842 master.cpp:7158] Framework failover timeout, removing framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.833431 27842 master.cpp:8012] Removing framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (default)
I0525 21:08:46.833480 27842 master.cpp:8580] Updating the state of task e8c0bd21-974a-4cc6-beea-95ecce0d5074 of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0525 21:08:46.833492 27849 slave.cpp:3061] Asked to shut down framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 by master@172.17.0.3:55373
I0525 21:08:46.833530 27849 slave.cpp:3086] Shutting down framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.833497 27842 master.cpp:8674] Removing task e8c0bd21-974a-4cc6-beea-95ecce0d5074 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.833662 27842 master.cpp:8703] Removing executor 'default' with resources {} of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 on agent 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-S0 at slave(692)@172.17.0.3:55373 (0958260158b0)
I0525 21:08:46.833555 27849 slave.cpp:5488] Shutting down executor 'default' of framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000 (via HTTP)
I0525 21:08:46.833920 27843 hierarchical.cpp:325] Removed framework 7b02b418-609c-4ff8-b5ad-a40fa1f41b90-0000
I0525 21:08:46.834537 27855 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.3:55373/slave(692)/api/v1/executor
*** Aborted at 1495746526 (unix time) try "date -d @1495746526" if you are using GNU date ***
PC: @          0x1df8d11 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x358) received by PID 27839 (TID 0x2af46b634700) from PID 856; stack trace: ***
    @     0x2af460c1b330 (unknown)
    @          0x1df8d11 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
    @           0xe50211 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
    @           0xe73477 mesos::internal::tests::executor::TestMesos<>::events()
    @           0xe5ed4d std::_Function_handler<>::_M_invoke()
    @     0x2af45df57c55 process::AsyncExecutorProcess::execute<>()
    @     0x2af45df61da5 _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_
    @     0x2af45ef97a01 process::ProcessManager::resume()
    @     0x2af45efa0de7 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
    @     0x2af460edaa60 (unknown)
    @     0x2af460c13184 start_thread
    @     0x2af461746bed (unknown)
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-1495742813-4120
Untagged: mesos-1495742813-4120:latest
Deleted: sha256:03334f54da582db1e0953f371ce1e4f95315d869b453da84869c7e5e6edd0c95
Deleted: sha256:a1fe026a2f5cfdf0161a44d03afb3025010fb96ca9b73a4885a5ed15223c0f2c
Deleted: sha256:bda7ceb9279b364b75883935006f721850a04301072d153d48dccd9aa9f3d1b3
Deleted: sha256:e3880642d0791f30199934f098bdc0e305a67002b9520b021ce35b1ff2876c05
Deleted: sha256:b49c4eb6b8770307d1b99be2e13959c2990e282305dbeb2765822603c0a05661
Deleted: sha256:3e7394c6e350438474883331d6f98ff95189d842a08bd9bf0b59e112b46e124f
Deleted: sha256:7d0501a4b7b7f1e4c491088476c34bdbda16fb678ee5f77f2e14bc7ac8aa1fa3
Deleted: sha256:ee913c313a2a54791975acc88157e8d57fca5d2de781441d38a198a5a54b1f60
Deleted: sha256:3f72fe9ad4b2dcba04b3c02729601ab139e23886ecb86d7eb221a151d577617e
Deleted: sha256:69e2c84fbb04ea39b931ba9967547a6d1334ff88c0324dd6671f5245b4d190a4
Deleted: sha256:909718788d98e2359fbcd317c4296bb2e4c700a17510457109f99b7167855474
Deleted: sha256:0353e728f8b8088a4d10b907c45cb694417b3a3ddbdc1a6e8fb206b30629fefd
Deleted: sha256:97f79a44781e2722fe70fb023f58f348cf9669003d2a318b3ad46b4ca2bce37c
Deleted: sha256:20177bc5b095839febb41074040eecbe36a7378979af5f0f996fb1a9d0b3dd39
Deleted: sha256:525efd6ac2677d000ecad707aec537a2b404737008a421d45c1f65835dbc3c85
Deleted: sha256:8f404d0d4b2147ebd9fc6b4833843d0978ba61dcdfb5e36d1447bbd3328c1652
Deleted: sha256:ab18ec2141b1ff70ffee9b02c588fce0d7062d74cccfbceba56b380fe2bf1a20
Deleted: sha256:acdefccf5753e67fcbacc6bddc247500ec0400c878d5df0324177b2f5f6e8b0e
Deleted: sha256:9de2eb1c0266c3532791492d131cee2c9991badc77c4855585b4629e16a0a404
Deleted: sha256:76a0f16d1e6636fb003fc03c4545d87702db174bc15c3515bd4213383b070626
Deleted: sha256:b004b8e7e637de97a049704faacb932adff8a5ce757327dbefa648bef75a3398
Deleted: sha256:a09df667174ba180b7ac15fd8308b6bdac9f5a49dc378bfaed431d8a4654a415
Deleted: sha256:731737667eee0a5ca6f4815c3f3df32bb332b9997823cb0347104bd3ec5c58fe
Deleted: sha256:314925b1b78b0b3ad55d2c4a9426a6efe0da3a9382ca0d6bec4eac1c37342cb4
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user neil.conway@gmail.com

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

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=ubuntu%3A14.04,label_exp=(docker%7C%7CHadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2)/3727/display/redirect?page=changes>