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/03/15 20:56:40 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) #3375
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)/3375/display/redirect?page=changes>
Changes:
[xujyan] Agent cgroup assignment should precede agent initialization.
------------------------------------------
[...truncated 23.09 MB...]
W0315 20:56:35.786994 26690 master.cpp:6367] Ignoring unknown exited executor 'default' of framework b7afaf7b-34ee-4da0-8031-667887d6387c-0000 on agent b7afaf7b-34ee-4da0-8031-667887d6387c-S0 at slave(651)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.787122 26686 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_1_3tdSxW/slaves/b7afaf7b-34ee-4da0-8031-667887d6387c-S0/frameworks/b7afaf7b-34ee-4da0-8031-667887d6387c-0000/executors/default/runs/3329870e-1e12-41b3-be18-764f2a05d043' for gc 6.99999089064889days in the future
I0315 20:56:35.787142 26695 slave.cpp:5024] Cleaning up framework b7afaf7b-34ee-4da0-8031-667887d6387c-0000
I0315 20:56:35.787225 26686 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_1_3tdSxW/slaves/b7afaf7b-34ee-4da0-8031-667887d6387c-S0/frameworks/b7afaf7b-34ee-4da0-8031-667887d6387c-0000/executors/default' for gc 6.99999088974519days in the future
I0315 20:56:35.787292 26690 status_update_manager.cpp:285] Closing status update streams for framework b7afaf7b-34ee-4da0-8031-667887d6387c-0000
I0315 20:56:35.787312 26690 status_update_manager.cpp:531] Cleaning up status update stream for task e20a801f-2a8d-455e-adf5-7410ef4f1cdb of framework b7afaf7b-34ee-4da0-8031-667887d6387c-0000
I0315 20:56:35.787351 26695 slave.cpp:693] Agent terminating
I0315 20:56:35.787478 26698 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_ReconcileTask_1_3tdSxW/slaves/b7afaf7b-34ee-4da0-8031-667887d6387c-S0/frameworks/b7afaf7b-34ee-4da0-8031-667887d6387c-0000' for gc 6.99999088759111days in the future
I0315 20:56:35.787578 26687 master.cpp:1317] Agent b7afaf7b-34ee-4da0-8031-667887d6387c-S0 at slave(651)@172.17.0.2:39132 (b943ec36646a) disconnected
I0315 20:56:35.787636 26687 master.cpp:3185] Disconnecting agent b7afaf7b-34ee-4da0-8031-667887d6387c-S0 at slave(651)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.787731 26687 master.cpp:3204] Deactivating agent b7afaf7b-34ee-4da0-8031-667887d6387c-S0 at slave(651)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.787819 26695 hierarchical.cpp:655] Agent b7afaf7b-34ee-4da0-8031-667887d6387c-S0 deactivated
I0315 20:56:35.789294 26684 master.cpp:1156] Master terminating
I0315 20:56:35.789700 26689 hierarchical.cpp:560] Removed agent b7afaf7b-34ee-4da0-8031-667887d6387c-S0
[ OK ] ContentType/SchedulerTest.ReconcileTask/1 (91 ms)
[ RUN ] ContentType/SchedulerTest.KillTask/0
I0315 20:56:35.794385 26684 cluster.cpp:160] Creating default 'local' authorizer
I0315 20:56:35.795447 26693 master.cpp:437] Master 42e73f64-0d90-4532-80b9-4c6d86dde795 (b943ec36646a) started on 172.17.0.2:39132
I0315 20:56:35.795471 26693 master.cpp:439] 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/CqxJ41/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" --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/CqxJ41/master" --zk_session_timeout="10secs"
I0315 20:56:35.795734 26693 master.cpp:489] Master only allowing authenticated frameworks to register
I0315 20:56:35.795745 26693 master.cpp:503] Master only allowing authenticated agents to register
I0315 20:56:35.795753 26693 master.cpp:516] Master only allowing authenticated HTTP frameworks to register
I0315 20:56:35.795759 26693 credentials.hpp:37] Loading credentials for authentication from '/tmp/CqxJ41/credentials'
I0315 20:56:35.795904 26693 master.cpp:561] Using default 'crammd5' authenticator
I0315 20:56:35.795967 26693 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0315 20:56:35.796044 26693 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0315 20:56:35.796139 26693 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0315 20:56:35.796213 26693 master.cpp:641] Authorization enabled
I0315 20:56:35.796325 26695 whitelist_watcher.cpp:77] No whitelist given
I0315 20:56:35.796373 26690 hierarchical.cpp:159] Initialized hierarchical allocator process
I0315 20:56:35.797127 26687 master.cpp:2165] Elected as the leading master!
I0315 20:56:35.797147 26687 master.cpp:1704] Recovering from registrar
I0315 20:56:35.797368 26697 registrar.cpp:331] Recovering registrar
I0315 20:56:35.797608 26696 registrar.cpp:364] Successfully fetched the registry (0B) in 185088ns
I0315 20:56:35.797659 26696 registrar.cpp:463] Applied 1 operations in 5843ns; attempting to update the registry
I0315 20:56:35.798001 26693 registrar.cpp:508] Successfully updated the registry in 306944ns
I0315 20:56:35.798068 26693 registrar.cpp:394] Successfully recovered registrar
I0315 20:56:35.798292 26694 master.cpp:1803] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0315 20:56:35.798311 26688 hierarchical.cpp:186] Skipping recovery of hierarchical allocator: nothing to recover
I0315 20:56:35.800838 26684 cluster.cpp:446] Creating default 'local' authorizer
I0315 20:56:35.801337 26690 slave.cpp:210] Mesos agent started on (652)@172.17.0.2:39132
I0315 20:56:35.801645 26684 scheduler.cpp:184] Version: 1.3.0
I0315 20:56:35.801357 26690 slave.cpp:211] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/mesos/store/appc" --authenticate_http_readonly="true" --authenticate_http_readwrite="true" --authenticatee="crammd5" --authentication_backoff_factor="1secs" --authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" --cgroups_enable_cfs="false" --cgroups_hierarchy="/sys/fs/cgroup" --cgroups_limit_swap="false" --cgroups_root="mesos" --container_disk_watch_interval="15secs" --containerizers="mesos" --credential="/tmp/ContentType_SchedulerTest_KillTask_0_4Onxb5/credential" --default_role="*" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/mesos/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_KillTask_0_4Onxb5/fetch" --fetcher_cache_size="2GB" --frameworks_home="" --gc_delay="1weeks" --gc_disk_headroom="0.1" --hadoop_home="" --help="false" --hostname_lookup="true" --http_authenticators="basic" --http_command_executor="false" --http_credentials="/tmp/ContentType_SchedulerTest_KillTask_0_4Onxb5/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" --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_4Onxb5" --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_aPW7C3"
I0315 20:56:35.801731 26690 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_KillTask_0_4Onxb5/credential'
I0315 20:56:35.801844 26690 slave.cpp:243] Agent using credential for: test-principal
I0315 20:56:35.801863 26690 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_KillTask_0_4Onxb5/http_credentials'
I0315 20:56:35.801995 26696 scheduler.cpp:470] New master detected at master@172.17.0.2:39132
I0315 20:56:35.802024 26696 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0315 20:56:35.802053 26690 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0315 20:56:35.802136 26690 http.cpp:957] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0315 20:56:35.802646 26689 scheduler.cpp:361] Connected with the master at http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.802700 26690 slave.cpp:430] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0315 20:56:35.802752 26690 slave.cpp:438] Agent attributes: [ ]
I0315 20:56:35.802759 26690 slave.cpp:443] Agent hostname: b943ec36646a
I0315 20:56:35.802953 26700 status_update_manager.cpp:177] Pausing sending status updates
I0315 20:56:35.803231 26685 state.cpp:62] Recovering state from '/tmp/ContentType_SchedulerTest_KillTask_0_aPW7C3/meta'
I0315 20:56:35.803519 26685 status_update_manager.cpp:203] Recovering status update manager
I0315 20:56:35.803696 26700 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.803741 26689 slave.cpp:5638] Finished recovery
I0315 20:56:35.804105 26689 slave.cpp:5820] Querying resource estimator for oversubscribable resources
I0315 20:56:35.804196 26689 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0315 20:56:35.804312 26698 slave.cpp:821] New master detected at master@172.17.0.2:39132
I0315 20:56:35.804347 26693 status_update_manager.cpp:177] Pausing sending status updates
I0315 20:56:35.804352 26698 slave.cpp:856] Detecting new master
I0315 20:56:35.804424 26698 slave.cpp:5834] Received oversubscribable resources {} from the resource estimator
I0315 20:56:35.804810 26687 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:43264
I0315 20:56:35.804889 26687 master.cpp:2517] Received subscription request for HTTP framework 'default'
I0315 20:56:35.804929 26687 master.cpp:2201] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0315 20:56:35.805155 26685 master.cpp:2632] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0315 20:56:35.805347 26695 master.hpp:2179] Sending heartbeat to 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.805409 26699 hierarchical.cpp:271] Added framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.805555 26699 hierarchical.cpp:1854] No allocations performed
I0315 20:56:35.805578 26699 hierarchical.cpp:1944] No inverse offers to send out!
I0315 20:56:35.805598 26699 hierarchical.cpp:1438] Performed allocation for 0 agents in 53547ns
I0315 20:56:35.805781 26688 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.806004 26688 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.808845 26688 slave.cpp:883] Authenticating with master master@172.17.0.2:39132
I0315 20:56:35.808882 26688 slave.cpp:894] Using default CRAM-MD5 authenticatee
I0315 20:56:35.808975 26695 authenticatee.cpp:121] Creating new client SASL connection
I0315 20:56:35.809160 26690 master.cpp:7252] Authenticating slave(652)@172.17.0.2:39132
I0315 20:56:35.809231 26689 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1231)@172.17.0.2:39132
I0315 20:56:35.809324 26697 authenticator.cpp:98] Creating new server SASL connection
I0315 20:56:35.809502 26689 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0315 20:56:35.809525 26689 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0315 20:56:35.809574 26689 authenticator.cpp:204] Received SASL authentication start
I0315 20:56:35.809662 26689 authenticator.cpp:326] Authentication requires more steps
I0315 20:56:35.809716 26689 authenticatee.cpp:259] Received SASL authentication step
I0315 20:56:35.809917 26693 authenticator.cpp:232] Received SASL authentication step
I0315 20:56:35.809945 26693 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b943ec36646a' server FQDN: 'b943ec36646a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0315 20:56:35.809958 26693 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0315 20:56:35.809972 26693 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0315 20:56:35.809993 26693 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'b943ec36646a' server FQDN: 'b943ec36646a' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0315 20:56:35.810012 26693 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0315 20:56:35.810029 26693 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0315 20:56:35.810055 26693 authenticator.cpp:318] Authentication success
I0315 20:56:35.810133 26697 authenticatee.cpp:299] Authentication success
I0315 20:56:35.810155 26689 master.cpp:7282] Successfully authenticated principal 'test-principal' at slave(652)@172.17.0.2:39132
I0315 20:56:35.810205 26700 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1231)@172.17.0.2:39132
I0315 20:56:35.810339 26687 slave.cpp:978] Successfully authenticated with master master@172.17.0.2:39132
I0315 20:56:35.810421 26687 slave.cpp:1406] Will retry registration in 12.748757ms if necessary
I0315 20:56:35.810508 26695 master.cpp:5437] Registering agent at slave(652)@172.17.0.2:39132 (b943ec36646a) with id 42e73f64-0d90-4532-80b9-4c6d86dde795-S0
I0315 20:56:35.810691 26697 registrar.cpp:463] Applied 1 operations in 16317ns; attempting to update the registry
I0315 20:56:35.811120 26697 registrar.cpp:508] Successfully updated the registry in 390912ns
I0315 20:56:35.811383 26688 slave.cpp:4421] Received ping from slave-observer(584)@172.17.0.2:39132
I0315 20:56:35.811406 26695 master.cpp:5511] Registered agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0315 20:56:35.811458 26688 slave.cpp:1024] Registered with master master@172.17.0.2:39132; given agent ID 42e73f64-0d90-4532-80b9-4c6d86dde795-S0
I0315 20:56:35.811473 26688 fetcher.cpp:94] Clearing fetcher cache
I0315 20:56:35.811502 26698 hierarchical.cpp:527] Added agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 (b943ec36646a) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0315 20:56:35.811645 26697 status_update_manager.cpp:184] Resuming sending status updates
I0315 20:56:35.811877 26688 slave.cpp:1052] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_KillTask_0_aPW7C3/meta/slaves/42e73f64-0d90-4532-80b9-4c6d86dde795-S0/slave.info'
I0315 20:56:35.811898 26698 hierarchical.cpp:1944] No inverse offers to send out!
I0315 20:56:35.811925 26698 hierarchical.cpp:1438] Performed allocation for 1 agents in 334875ns
I0315 20:56:35.812073 26687 master.cpp:7081] Sending 1 offers to framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.812222 26688 slave.cpp:1090] Forwarding total oversubscribed resources {}
I0315 20:56:35.812328 26687 master.cpp:6098] Received update of agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a) with total oversubscribed resources {}
I0315 20:56:35.812837 26700 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.813854 26700 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.814393 26691 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0315 20:56:35.814857 26696 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:43263
I0315 20:56:35.815099 26696 master.cpp:3839] Processing ACCEPT call for offers: [ 42e73f64-0d90-4532-80b9-4c6d86dde795-O0 ] on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a) for framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.815145 26696 master.cpp:3415] Authorizing framework principal 'test-principal' to launch task c1b79c83-87e4-4d24-881a-5e62db0c705a
W0315 20:56:35.816061 26696 validation.cpp:1113] Executor 'default' for task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0315 20:56:35.816087 26696 validation.cpp:1125] Executor 'default' for task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0315 20:56:35.816233 26696 master.cpp:9097] Adding task c1b79c83-87e4-4d24-881a-5e62db0c705a with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.816340 26696 master.cpp:4489] Launching task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.816603 26700 slave.cpp:1516] Got assigned task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' for framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.816944 26700 slave.cpp:1797] Authorizing task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' for framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.816974 26700 slave.cpp:6257] Authorizing framework principal 'test-principal' to launch task c1b79c83-87e4-4d24-881a-5e62db0c705a
I0315 20:56:35.817134 26694 hierarchical.cpp:844] Updated allocation of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-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]
I0315 20:56:35.817421 26699 slave.cpp:1984] Launching task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' for framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.818053 26699 paths.cpp:547] Trying to chown '/tmp/ContentType_SchedulerTest_KillTask_0_aPW7C3/slaves/42e73f64-0d90-4532-80b9-4c6d86dde795-S0/frameworks/42e73f64-0d90-4532-80b9-4c6d86dde795-0000/executors/default/runs/84f59439-2ff2-4e4f-ba83-c56d5c3c9810' to user 'mesos'
I0315 20:56:35.818279 26699 slave.cpp:6604] Launching executor 'default' of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 with resources {} in work directory '/tmp/ContentType_SchedulerTest_KillTask_0_aPW7C3/slaves/42e73f64-0d90-4532-80b9-4c6d86dde795-S0/frameworks/42e73f64-0d90-4532-80b9-4c6d86dde795-0000/executors/default/runs/84f59439-2ff2-4e4f-ba83-c56d5c3c9810'
I0315 20:56:35.818565 26699 slave.cpp:2198] Queued task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' for executor 'default' of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.818650 26699 slave.cpp:774] Successfully attached file '/tmp/ContentType_SchedulerTest_KillTask_0_aPW7C3/slaves/42e73f64-0d90-4532-80b9-4c6d86dde795-S0/frameworks/42e73f64-0d90-4532-80b9-4c6d86dde795-0000/executors/default/runs/84f59439-2ff2-4e4f-ba83-c56d5c3c9810'
I0315 20:56:35.819469 26700 executor.cpp:192] Version: 1.3.0
I0315 20:56:35.820526 26685 executor.cpp:401] Connected with the agent
I0315 20:56:35.820890 26685 executor.cpp:302] Sending SUBSCRIBE call to http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.821377 26694 process.cpp:3705] Handling HTTP event for process 'slave(652)' with path: '/slave(652)/api/v1/executor'
I0315 20:56:35.821781 26699 http.cpp:331] HTTP POST for /slave(652)/api/v1/executor from 172.17.0.2:43265
I0315 20:56:35.821902 26699 slave.cpp:3244] Received Subscribe request for HTTP executor 'default' of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.822365 26699 slave.cpp:2411] Sending queued task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' to executor 'default' of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (via HTTP)
I0315 20:56:35.822935 26700 executor.cpp:716] Enqueuing event SUBSCRIBED received from http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.823170 26693 executor.cpp:716] Enqueuing event LAUNCH received from http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.823596 26685 executor.cpp:302] Sending UPDATE call to http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.823957 26694 process.cpp:3705] Handling HTTP event for process 'slave(652)' with path: '/slave(652)/api/v1/executor'
I0315 20:56:35.824292 26689 http.cpp:331] HTTP POST for /slave(652)/api/v1/executor from 172.17.0.2:43266
I0315 20:56:35.824350 26689 slave.cpp:3891] Handling status update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.824631 26694 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.824657 26694 status_update_manager.cpp:500] Creating StatusUpdate stream for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.824885 26694 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 to the agent
I0315 20:56:35.824985 26696 slave.cpp:4331] Forwarding the update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 to master@172.17.0.2:39132
I0315 20:56:35.825103 26696 slave.cpp:4225] Status update manager successfully handled status update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.825150 26700 master.cpp:6243] Status update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 from agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.825184 26700 master.cpp:6311] Forwarding status update TASK_RUNNING (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.825301 26700 master.cpp:8345] Updating the state of task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0315 20:56:35.825482 26692 executor.cpp:716] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.825623 26694 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.826408 26698 scheduler.cpp:243] Sending ACKNOWLEDGE call to http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.826529 26698 scheduler.cpp:243] Sending KILL call to http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.826766 26685 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0315 20:56:35.866288 26688 process.cpp:3705] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0315 20:56:35.866786 26691 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:43263
I0315 20:56:35.866842 26691 master.cpp:5151] Processing ACKNOWLEDGE call b33d1141-cbf0-447c-a21b-2cec54088c1b for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default) on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0
I0315 20:56:35.866964 26691 http.cpp:440] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:43263
I0315 20:56:35.867022 26691 master.cpp:4970] Processing KILL call for task 'c1b79c83-87e4-4d24-881a-5e62db0c705a' of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.867024 26692 status_update_manager.cpp:395] Received status update acknowledgement (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.867063 26691 master.cpp:5043] Telling agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a) to kill task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.867244 26699 slave.cpp:3180] Status update manager successfully handled status update acknowledgement (UUID: b33d1141-cbf0-447c-a21b-2cec54088c1b) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.867292 26699 slave.cpp:2508] Asked to kill task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.867688 26700 executor.cpp:716] Enqueuing event KILL received from http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.868058 26694 executor.cpp:302] Sending UPDATE call to http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.868481 26690 process.cpp:3705] Handling HTTP event for process 'slave(652)' with path: '/slave(652)/api/v1/executor'
I0315 20:56:35.906383 26698 http.cpp:331] HTTP POST for /slave(652)/api/v1/executor from 172.17.0.2:43266
I0315 20:56:35.906455 26698 slave.cpp:3891] Handling status update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.907039 26699 status_update_manager.cpp:323] Received status update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.907110 26699 status_update_manager.cpp:377] Forwarding update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 to the agent
I0315 20:56:35.907225 26689 slave.cpp:4331] Forwarding the update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 to master@172.17.0.2:39132
I0315 20:56:35.907371 26689 slave.cpp:4225] Status update manager successfully handled status update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.907411 26698 master.cpp:6243] Status update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 from agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.907454 26698 master.cpp:6311] Forwarding status update TASK_KILLED (UUID: 45f67986-5009-42b0-b46b-475fcc44ea03) for task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.907619 26698 master.cpp:8345] Updating the state of task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0315 20:56:35.907914 26689 executor.cpp:716] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:39132/slave(652)/api/v1/executor
I0315 20:56:35.908080 26690 hierarchical.cpp:1108] 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 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 from framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.908143 26686 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:39132/master/api/v1/scheduler
I0315 20:56:35.909225 26692 master.cpp:1434] Framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default) disconnected
I0315 20:56:35.909466 26692 master.cpp:3148] Deactivating framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.909610 26692 master.cpp:3125] Disconnecting framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.909631 26692 master.cpp:1449] Giving framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default) 0ns to failover
I0315 20:56:35.909657 26691 hierarchical.cpp:376] Deactivated framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.909818 26689 master.cpp:6921] Framework failover timeout, removing framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.909868 26689 master.cpp:7777] Removing framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (default)
I0315 20:56:35.909947 26689 master.cpp:8345] Updating the state of task c1b79c83-87e4-4d24-881a-5e62db0c705a of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0315 20:56:35.909981 26695 slave.cpp:2738] Asked to shut down framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 by master@172.17.0.2:39132
I0315 20:56:35.909967 26689 master.cpp:8439] Removing task c1b79c83-87e4-4d24-881a-5e62db0c705a with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.910049 26695 slave.cpp:2763] Shutting down framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.910073 26695 slave.cpp:5150] Shutting down executor 'default' of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 (via HTTP)
I0315 20:56:35.910116 26689 master.cpp:8468] Removing executor 'default' with resources {} of framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000 on agent 42e73f64-0d90-4532-80b9-4c6d86dde795-S0 at slave(652)@172.17.0.2:39132 (b943ec36646a)
I0315 20:56:35.910279 26695 hierarchical.cpp:323] Removed framework 42e73f64-0d90-4532-80b9-4c6d86dde795-0000
I0315 20:56:35.910732 26689 executor.cpp:716] Enqueuing event SHUTDOWN received from http://172.17.0.2:39132/slave(652)/api/v1/executor
*** Aborted at 1489611395 (unix time) try "date -d @1489611395" if you are using GNU date ***
PC: @ 0x1c099ed testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x358) received by PID 26684 (TID 0x7f300ad16700) from PID 856; stack trace: ***
@ 0x7f3010fd7370 (unknown)
@ 0x1c099ed testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0xdab571 mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0xdcefb7 mesos::internal::tests::executor::TestMesos<>::events()
@ 0xdbae7d std::_Function_handler<>::_M_invoke()
@ 0x7f30153d1e55 process::AsyncExecutorProcess::execute<>()
@ 0x7f30153db8d1 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeISC_SaISC_EEEEESG_PvSK_SG_SN_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSS_FSP_T1_T2_T3_ET4_T5_T6_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
@ 0x7f30142c4271 process::ProcessManager::resume()
@ 0x7f30142cd2f7 _ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUt_vEEE6_M_runEv
@ 0x7f3010d74230 (unknown)
@ 0x7f3010fcfdc5 start_thread
@ 0x7f30104dd73d __clone
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Segmentation fault
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-1489608983-10671
Untagged: mesos-1489608983-10671:latest
Deleted: sha256:1c120a08d508dc8c51daf7cc43f728d139fb7f912df44592e6863d9ff1c08805
Deleted: sha256:e730e2cd426ec02492c51e36d2a4689d297fe077872f9b810ccc6875f556007f
Deleted: sha256:35f21a0eaef25af8c00c815a099300cc0ede750e184533d23d7ac406c45edc49
Deleted: sha256:2c5886b290b28aa9fe37aa45d4930464e87c5e6d35bc3f6dfcfe01ba67406ff3
Deleted: sha256:ea216f7a1586b3c074a7526c2deb80a230036af9eba86cd16283181f53746b1a
Deleted: sha256:4e924d4c3fab339affd25f8b3fafae5976796c334cd5b811281d91964255542f
Deleted: sha256:8eac221b831aa103d68c7ce58d50e87a135b602b1d1c09a10e029828806ff6de
Deleted: sha256:68fb598b9b02c81bc30c0d8d613fca6cf8d737c71e31547f92d4c05072cca325
Deleted: sha256:315909dd340911a09e5f0c4f9dc66634f5333562eabbfbf6654881a087c918b9
Deleted: sha256:e048cbca32c6b48a5531420974ddd152b7f1e9bbbf99617098446b1bb9f36117
Deleted: sha256:9066ba23d9fefd51f76ade4b5fe59e52acab850a44a44632c0a7a617f2c4cd63
Deleted: sha256:d3ac0b2591cf8ab728a15352fe4feabf6b47d62704928f0e559401c1c4bb66c1
Deleted: sha256:06a28ce49297380173b1aea74b2511260d41769eaeb44f8f023d1cf698fe462b
Deleted: sha256:156af68c1c735ecc239af86f1df1fe7a922d62965580e566425a36a5fa919084
Deleted: sha256:d23966c1c3d67c79d31715f65b20a0667f4c5d0f3c3c5ea5a262651b67cabdf6
Deleted: sha256:24e5b2482c36d556384dc8544cebaae22da55aacdf7611b0e01a0ee2d9277948
Deleted: sha256:1c69e3802330aa80410295fe4b4a49656b3968865189dbbf0bf71aa967b2317c
Deleted: sha256:7ccec37a7945aa4d05cefe530aff0ab67c7895577b575dda3391d7a8dad37a63
Deleted: sha256:e2f0c4964bfb74abfb89728c4a30c15f77fdc7578e6e522838e3f6b527a48e7f
Deleted: sha256:ff36cd8508bf70ac23d9d0b843079cdec592ed53cc23ef269522f132c347577e
Deleted: sha256:2cd063fc580d26dea05acb67e0dc6c7e10dfb5e832407e811fac953b3afd21c4
Deleted: sha256:8a2f596a5ee637defe31b9f63f44e459e2074a8d5442806f77b1dea02092764b
Deleted: sha256:84f3f2299e248bac43680741b8e32805fb0fbaa69cd4dfbf2902699780d7dc4a
Deleted: sha256:9a6a201493de2e2b59e6a253b8356c1b21fff74d52e9feebd5da867a0a7314b6
Deleted: sha256:f916ac38047131e63141c6b8326c6d97878bfe95be828c8b8088ec99fc686884
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) #3376
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)/3376/display/redirect?page=changes>