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/18 16:36:39 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3692
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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)/3692/display/redirect?page=changes>
Changes:
[yujie.jay] Updated the outdated network isolator configure flag.
------------------------------------------
[...truncated 25.13 MB...]
I0518 16:36:34.705467 26031 master.cpp:1430] Framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (default) disconnected
I0518 16:36:34.705679 26031 master.cpp:3160] Deactivating framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (default)
I0518 16:36:34.705796 26031 master.cpp:3137] Disconnecting framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (default)
I0518 16:36:34.705919 26031 master.cpp:1445] Giving framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (default) 0ns to failover
I0518 16:36:34.706079 26030 slave.cpp:794] Agent terminating
I0518 16:36:34.705855 26041 hierarchical.cpp:374] Deactivated framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.706307 26034 master.cpp:7146] Framework failover timeout, removing framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (default)
I0518 16:36:34.706332 26034 master.cpp:8000] Removing framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (default)
I0518 16:36:34.706393 26034 master.cpp:8568] Updating the state of task 0df90500-9762-40ce-af5e-4d1520ac58b6 of framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0518 16:36:34.706226 26030 slave.cpp:3061] Asked to shut down framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 by @0.0.0.0:0
I0518 16:36:34.706648 26030 slave.cpp:3086] Shutting down framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.706812 26030 slave.cpp:5272] Cleaning up executor 'default' of framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 (via HTTP)
I0518 16:36:34.706974 26036 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 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0 from framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.707185 26036 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_Message_0_C8WlsG/slaves/3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0/frameworks/3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000/executors/default/runs/758a566b-f16a-419c-a6be-01e1cf26c303' for gc 6.99999181592593days in the future
I0518 16:36:34.707226 26030 slave.cpp:5360] Cleaning up framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.707337 26036 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_Message_0_C8WlsG/slaves/3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0/frameworks/3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000/executors/default' for gc 6.99999181477926days in the future
I0518 16:36:34.707772 26036 gc.cpp:55] Scheduling '/tmp/ContentType_SchedulerTest_Message_0_C8WlsG/slaves/3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0/frameworks/3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000' for gc 6.99999181066074days in the future
I0518 16:36:34.707548 26032 status_update_manager.cpp:285] Closing status update streams for framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.708318 26032 status_update_manager.cpp:531] Cleaning up status update stream for task 0df90500-9762-40ce-af5e-4d1520ac58b6 of framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.706650 26034 master.cpp:8662] Removing task 0df90500-9762-40ce-af5e-4d1520ac58b6 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000 on agent 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0 at slave(701)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.708612 26034 master.cpp:1313] Agent 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0 at slave(701)@172.17.0.2:53952 (9e583b8370dd) disconnected
I0518 16:36:34.708648 26031 hierarchical.cpp:325] Removed framework 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-0000
I0518 16:36:34.708786 26034 master.cpp:3197] Disconnecting agent 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0 at slave(701)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.709018 26034 master.cpp:3216] Deactivating agent 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0 at slave(701)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.709213 26034 master.cpp:1155] Master terminating
I0518 16:36:34.709275 26042 hierarchical.cpp:653] Agent 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0 deactivated
I0518 16:36:34.709437 26042 hierarchical.cpp:558] Removed agent 3f2b08e7-678b-4d7d-b27f-5d1b9b8f5f5d-S0
[ OK ] ContentType/SchedulerTest.Message/0 (85 ms)
[ RUN ] ContentType/SchedulerTest.Message/1
I0518 16:36:34.713294 26030 cluster.cpp:162] Creating default 'local' authorizer
I0518 16:36:34.714365 26033 master.cpp:436] Master af4c18e0-481f-49ee-b8d0-f6c06920fff4 (9e583b8370dd) started on 172.17.0.2:53952
I0518 16:36:34.714395 26033 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/Yercar/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/Yercar/master" --zk_session_timeout="10secs"
I0518 16:36:34.714565 26033 master.cpp:488] Master only allowing authenticated frameworks to register
I0518 16:36:34.714574 26033 master.cpp:502] Master only allowing authenticated agents to register
I0518 16:36:34.714581 26033 master.cpp:515] Master only allowing authenticated HTTP frameworks to register
I0518 16:36:34.714591 26033 credentials.hpp:37] Loading credentials for authentication from '/tmp/Yercar/credentials'
I0518 16:36:34.714740 26033 master.cpp:560] Using default 'crammd5' authenticator
I0518 16:36:34.714800 26033 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0518 16:36:34.714869 26033 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0518 16:36:34.714907 26033 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0518 16:36:34.714943 26033 master.cpp:640] Authorization enabled
I0518 16:36:34.715054 26035 hierarchical.cpp:158] Initialized hierarchical allocator process
I0518 16:36:34.715138 26040 whitelist_watcher.cpp:77] No whitelist given
I0518 16:36:34.716256 26033 master.cpp:2161] Elected as the leading master!
I0518 16:36:34.716279 26033 master.cpp:1700] Recovering from registrar
I0518 16:36:34.716343 26043 registrar.cpp:345] Recovering registrar
I0518 16:36:34.716640 26043 registrar.cpp:389] Successfully fetched the registry (0B) in 134144ns
I0518 16:36:34.716686 26043 registrar.cpp:493] Applied 1 operations in 16590ns; attempting to update the registry
I0518 16:36:34.716977 26043 registrar.cpp:550] Successfully updated the registry in 183040ns
I0518 16:36:34.717021 26043 registrar.cpp:422] Successfully recovered registrar
I0518 16:36:34.717217 26043 hierarchical.cpp:185] Skipping recovery of hierarchical allocator: nothing to recover
I0518 16:36:34.717216 26046 master.cpp:1799] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
I0518 16:36:34.719776 26030 cluster.cpp:448] Creating default 'local' authorizer
I0518 16:36:34.720305 26036 slave.cpp:225] Mesos agent started on (702)@172.17.0.2:53952
I0518 16:36:34.720624 26030 scheduler.cpp:184] Version: 1.4.0
I0518 16:36:34.720355 26036 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_Message_1_JdTcQO/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_secret_key="/tmp/ContentType_SchedulerTest_Message_1_JdTcQO/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_SchedulerTest_Message_1_JdTcQO/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_Message_1_JdTcQO/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_Message_1_JdTcQO" --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_Message_1_rb1b07"
I0518 16:36:34.720674 26036 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_SchedulerTest_Message_1_JdTcQO/credential'
I0518 16:36:34.720839 26036 slave.cpp:258] Agent using credential for: test-principal
I0518 16:36:34.720937 26036 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_SchedulerTest_Message_1_JdTcQO/http_credentials'
I0518 16:36:34.720958 26037 scheduler.cpp:470] New master detected at master@172.17.0.2:53952
I0518 16:36:34.720976 26037 scheduler.cpp:479] Waiting for 0ns before initiating a re-(connection) attempt with the master
I0518 16:36:34.721201 26036 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
I0518 16:36:34.721254 26036 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
I0518 16:36:34.721459 26036 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0518 16:36:34.721498 26036 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
I0518 16:36:34.721698 26036 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
I0518 16:36:34.721737 26036 http.cpp:996] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readwrite'
I0518 16:36:34.722214 26041 scheduler.cpp:361] Connected with the master at http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.722491 26036 slave.cpp:529] Agent resources: cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0518 16:36:34.722543 26036 slave.cpp:537] Agent attributes: [ ]
I0518 16:36:34.722550 26036 slave.cpp:542] Agent hostname: 9e583b8370dd
I0518 16:36:34.722692 26033 status_update_manager.cpp:177] Pausing sending status updates
I0518 16:36:34.723023 26040 state.cpp:62] Recovering state from '/tmp/ContentType_SchedulerTest_Message_1_rb1b07/meta'
I0518 16:36:34.723296 26039 status_update_manager.cpp:203] Recovering status update manager
I0518 16:36:34.723342 26033 scheduler.cpp:243] Sending SUBSCRIBE call to http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.723598 26040 slave.cpp:5974] Finished recovery
I0518 16:36:34.724097 26041 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0518 16:36:34.724119 26040 slave.cpp:6156] Querying resource estimator for oversubscribable resources
I0518 16:36:34.724498 26037 slave.cpp:922] New master detected at master@172.17.0.2:53952
I0518 16:36:34.724524 26036 status_update_manager.cpp:177] Pausing sending status updates
I0518 16:36:34.724562 26037 slave.cpp:957] Detecting new master
I0518 16:36:34.724658 26037 slave.cpp:6170] Received oversubscribable resources {} from the resource estimator
I0518 16:36:34.724828 26033 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40615
I0518 16:36:34.725064 26033 master.cpp:2513] Received subscription request for HTTP framework 'default'
I0518 16:36:34.725087 26033 master.cpp:2197] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
I0518 16:36:34.725312 26033 master.cpp:2628] Subscribing framework 'default' with checkpointing disabled and capabilities [ ]
I0518 16:36:34.725543 26036 hierarchical.cpp:273] Added framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.725616 26036 hierarchical.cpp:1850] No allocations performed
I0518 16:36:34.725636 26036 hierarchical.cpp:1940] No inverse offers to send out!
I0518 16:36:34.725656 26036 hierarchical.cpp:1434] Performed allocation for 0 agents in 56314ns
I0518 16:36:34.725741 26044 master.hpp:2194] Sending heartbeat to af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.726269 26037 scheduler.cpp:676] Enqueuing event SUBSCRIBED received from http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.726595 26037 scheduler.cpp:676] Enqueuing event HEARTBEAT received from http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.733331 26046 slave.cpp:984] Authenticating with master master@172.17.0.2:53952
I0518 16:36:34.733431 26046 slave.cpp:995] Using default CRAM-MD5 authenticatee
I0518 16:36:34.733630 26045 authenticatee.cpp:121] Creating new client SASL connection
I0518 16:36:34.733857 26046 master.cpp:7475] Authenticating slave(702)@172.17.0.2:53952
I0518 16:36:34.733927 26045 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1296)@172.17.0.2:53952
I0518 16:36:34.734074 26044 authenticator.cpp:98] Creating new server SASL connection
I0518 16:36:34.734232 26046 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0518 16:36:34.734256 26046 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0518 16:36:34.734309 26046 authenticator.cpp:204] Received SASL authentication start
I0518 16:36:34.734365 26046 authenticator.cpp:326] Authentication requires more steps
I0518 16:36:34.734412 26046 authenticatee.cpp:259] Received SASL authentication step
I0518 16:36:34.734494 26035 authenticator.cpp:232] Received SASL authentication step
I0518 16:36:34.734524 26035 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '9e583b8370dd' server FQDN: '9e583b8370dd' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0518 16:36:34.734537 26035 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0518 16:36:34.734557 26035 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0518 16:36:34.734570 26035 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '9e583b8370dd' server FQDN: '9e583b8370dd' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0518 16:36:34.734580 26035 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0518 16:36:34.734591 26035 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0518 16:36:34.734608 26035 authenticator.cpp:318] Authentication success
I0518 16:36:34.734660 26036 authenticatee.cpp:299] Authentication success
I0518 16:36:34.734716 26046 master.cpp:7505] Successfully authenticated principal 'test-principal' at slave(702)@172.17.0.2:53952
I0518 16:36:34.734764 26035 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1296)@172.17.0.2:53952
I0518 16:36:34.734916 26036 slave.cpp:1079] Successfully authenticated with master master@172.17.0.2:53952
I0518 16:36:34.735111 26036 slave.cpp:1507] Will retry registration in 12.338271ms if necessary
I0518 16:36:34.735167 26035 master.cpp:5429] Received register agent message from slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.735275 26035 master.cpp:3659] Authorizing agent with principal 'test-principal'
I0518 16:36:34.735512 26036 master.cpp:5564] Registering agent at slave(702)@172.17.0.2:53952 (9e583b8370dd) with id af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0
I0518 16:36:34.735671 26035 registrar.cpp:493] Applied 1 operations in 27227ns; attempting to update the registry
I0518 16:36:34.735915 26035 registrar.cpp:550] Successfully updated the registry in 217088ns
I0518 16:36:34.736181 26039 slave.cpp:4749] Received ping from slave-observer(635)@172.17.0.2:53952
I0518 16:36:34.736207 26043 master.cpp:5639] Registered agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000]
I0518 16:36:34.736312 26044 hierarchical.cpp:525] Added agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 (9e583b8370dd) with cpus(*):2; mem(*):1024; disk(*):1024; ports(*):[31000-32000] (allocated: {})
I0518 16:36:34.736532 26039 slave.cpp:1125] Registered with master master@172.17.0.2:53952; given agent ID af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0
I0518 16:36:34.736665 26039 fetcher.cpp:94] Clearing fetcher cache
I0518 16:36:34.736708 26044 hierarchical.cpp:1940] No inverse offers to send out!
I0518 16:36:34.736814 26044 hierarchical.cpp:1434] Performed allocation for 1 agents in 424571ns
I0518 16:36:34.736877 26045 master.cpp:7305] Sending 1 offers to framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default)
I0518 16:36:34.736966 26040 status_update_manager.cpp:184] Resuming sending status updates
I0518 16:36:34.737174 26039 slave.cpp:1153] Checkpointing SlaveInfo to '/tmp/ContentType_SchedulerTest_Message_1_rb1b07/meta/slaves/af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0/slave.info'
I0518 16:36:34.737458 26039 slave.cpp:1191] Forwarding total oversubscribed resources {}
I0518 16:36:34.737542 26039 master.cpp:6324] Received update of agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd) with total oversubscribed resources {}
I0518 16:36:34.738085 26032 scheduler.cpp:676] Enqueuing event OFFERS received from http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.738976 26034 scheduler.cpp:243] Sending ACCEPT call to http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.739909 26043 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0518 16:36:34.740331 26031 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40616
I0518 16:36:34.741029 26031 master.cpp:3875] Processing ACCEPT call for offers: [ af4c18e0-481f-49ee-b8d0-f6c06920fff4-O0 ] on agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd) for framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default)
I0518 16:36:34.741078 26031 master.cpp:3426] Authorizing framework principal 'test-principal' to launch task 3b75d90d-d45c-43b3-a8dd-96e72e134108
W0518 16:36:34.741717 26031 validation.cpp:1284] Executor 'default' for task '3b75d90d-d45c-43b3-a8dd-96e72e134108' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
W0518 16:36:34.741749 26031 validation.cpp:1296] Executor 'default' for task '3b75d90d-d45c-43b3-a8dd-96e72e134108' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
I0518 16:36:34.741914 26031 master.cpp:9326] Adding task 3b75d90d-d45c-43b3-a8dd-96e72e134108 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.742035 26031 master.cpp:4531] Launching task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default) with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] on agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.742228 26039 slave.cpp:1617] Got assigned task '3b75d90d-d45c-43b3-a8dd-96e72e134108' for framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.742558 26039 slave.cpp:1898] Authorizing task '3b75d90d-d45c-43b3-a8dd-96e72e134108' for framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.742591 26039 slave.cpp:6593] Authorizing framework principal 'test-principal' to launch task 3b75d90d-d45c-43b3-a8dd-96e72e134108
I0518 16:36:34.742614 26031 hierarchical.cpp:850] Updated allocation of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 on agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-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]
I0518 16:36:34.742964 26043 slave.cpp:2085] Launching task '3b75d90d-d45c-43b3-a8dd-96e72e134108' for framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.743458 26043 paths.cpp:573] Trying to chown '/tmp/ContentType_SchedulerTest_Message_1_rb1b07/slaves/af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0/frameworks/af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000/executors/default/runs/b6d4ac05-b882-4b6e-a27d-91530d42c2c2' to user 'mesos'
I0518 16:36:34.743674 26043 slave.cpp:6933] Launching executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 with resources {} in work directory '/tmp/ContentType_SchedulerTest_Message_1_rb1b07/slaves/af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0/frameworks/af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000/executors/default/runs/b6d4ac05-b882-4b6e-a27d-91530d42c2c2'
I0518 16:36:34.743954 26043 slave.cpp:2314] Queued task '3b75d90d-d45c-43b3-a8dd-96e72e134108' for executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.744006 26043 slave.cpp:875] Successfully attached file '/tmp/ContentType_SchedulerTest_Message_1_rb1b07/slaves/af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0/frameworks/af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000/executors/default/runs/b6d4ac05-b882-4b6e-a27d-91530d42c2c2'
I0518 16:36:34.745457 26037 executor.cpp:192] Version: 1.4.0
I0518 16:36:34.746433 26032 executor.cpp:410] Connected with the agent
I0518 16:36:34.746707 26032 executor.cpp:307] Sending SUBSCRIBE call to http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.747355 26032 process.cpp:3730] Handling HTTP event for process 'slave(702)' with path: '/slave(702)/api/v1/executor'
I0518 16:36:34.748208 26032 http.cpp:1115] HTTP POST for /slave(702)/api/v1/executor from 172.17.0.2:40617
I0518 16:36:34.748581 26032 slave.cpp:3572] Received Subscribe request for HTTP executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.749321 26032 slave.cpp:2527] Sending queued task '3b75d90d-d45c-43b3-a8dd-96e72e134108' to executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (via HTTP)
I0518 16:36:34.750037 26042 executor.cpp:725] Enqueuing event SUBSCRIBED received from http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.750298 26042 executor.cpp:725] Enqueuing event LAUNCH received from http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.750602 26042 executor.cpp:307] Sending UPDATE call to http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.751236 26045 process.cpp:3730] Handling HTTP event for process 'slave(702)' with path: '/slave(702)/api/v1/executor'
I0518 16:36:34.752111 26032 http.cpp:1115] HTTP POST for /slave(702)/api/v1/executor from 172.17.0.2:40618
I0518 16:36:34.752202 26032 slave.cpp:4219] Handling status update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.752490 26035 status_update_manager.cpp:323] Received status update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.752542 26035 status_update_manager.cpp:500] Creating StatusUpdate stream for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.752832 26035 status_update_manager.cpp:377] Forwarding update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 to the agent
I0518 16:36:34.752988 26035 slave.cpp:4659] Forwarding the update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 to master@172.17.0.2:53952
I0518 16:36:34.753088 26035 slave.cpp:4553] Status update manager successfully handled status update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.753249 26035 master.cpp:6469] Status update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 from agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.753279 26035 master.cpp:6537] Forwarding status update TASK_RUNNING (UUID: cd30356b-8bec-4a7f-a3ff-22a12399e2fd) for task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.753674 26035 master.cpp:8568] Updating the state of task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (latest state: TASK_RUNNING, status update state: TASK_RUNNING)
I0518 16:36:34.753674 26034 executor.cpp:725] Enqueuing event ACKNOWLEDGED received from http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.754120 26041 scheduler.cpp:676] Enqueuing event UPDATE received from http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.754997 26043 scheduler.cpp:243] Sending MESSAGE call to http://172.17.0.2:53952/master/api/v1/scheduler
I0518 16:36:34.755565 26031 process.cpp:3730] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
I0518 16:36:34.792994 26037 http.cpp:1115] HTTP POST for /master/api/v1/scheduler from 172.17.0.2:40616
I0518 16:36:34.793195 26037 master.cpp:5362] Processing MESSAGE call from framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default) to agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.793831 26037 executor.cpp:725] Enqueuing event MESSAGE received from http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.795029 26046 master.cpp:1430] Framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default) disconnected
I0518 16:36:34.795063 26046 master.cpp:3160] Deactivating framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default)
I0518 16:36:34.795086 26046 master.cpp:3137] Disconnecting framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default)
I0518 16:36:34.795109 26046 master.cpp:1445] Giving framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default) 0ns to failover
I0518 16:36:34.795280 26042 master.cpp:7146] Framework failover timeout, removing framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default)
I0518 16:36:34.795305 26042 master.cpp:8000] Removing framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (default)
I0518 16:36:34.795377 26042 master.cpp:8568] Updating the state of task 3b75d90d-d45c-43b3-a8dd-96e72e134108 of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (latest state: TASK_KILLED, status update state: TASK_KILLED)
I0518 16:36:34.795397 26043 slave.cpp:3061] Asked to shut down framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 by master@172.17.0.2:53952
I0518 16:36:34.795449 26043 slave.cpp:3086] Shutting down framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.795507 26043 slave.cpp:5486] Shutting down executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (via HTTP)
I0518 16:36:34.795611 26042 master.cpp:8662] Removing task 3b75d90d-d45c-43b3-a8dd-96e72e134108 with resources cpus(*)(allocated: *):2; mem(*)(allocated: *):1024; disk(*)(allocated: *):1024; ports(*)(allocated: *):[31000-32000] of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 on agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.795761 26042 master.cpp:8691] Removing executor 'default' with resources {} of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 on agent af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 at slave(702)@172.17.0.2:53952 (9e583b8370dd)
I0518 16:36:34.795991 26046 hierarchical.cpp:374] Deactivated framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.796342 26042 executor.cpp:725] Enqueuing event SHUTDOWN received from http://172.17.0.2:53952/slave(702)/api/v1/executor
I0518 16:36:34.796608 26046 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 af4c18e0-481f-49ee-b8d0-f6c06920fff4-S0 from framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
I0518 16:36:34.796967 26042 slave.cpp:5172] Executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 exited with status 0
*** Aborted at 1495125394 (unix time) try "date -d @1495125394" if you are using GNU date ***
I0518 16:36:34.797056 26042 slave.cpp:5272] Cleaning up executor 'default' of framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000 (via HTTP)
I0518 16:36:34.797291 26042 slave.cpp:5360] Cleaning up framework af4c18e0-481f-49ee-b8d0-f6c06920fff4-0000
PC: @ 0x2cfb571 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
*** SIGSEGV (@0x2b485c9284d8) received by PID 26030 (TID 0x2b48687c5700) from PID 1553106136; stack trace: ***
@ 0x2b485fbcf330 (unknown)
@ 0x2cfb571 testing::internal::UntypedFunctionMockerBase::SetOwnerAndName()
@ 0xd17bbd mesos::internal::tests::executor::MockHTTPExecutor<>::event()
@ 0xd171a1 mesos::internal::tests::executor::TestMesos<>::events()
@ 0xd1735a std::_Function_handler<>::_M_invoke()
@ 0x2b485b4d507c process::AsyncExecutorProcess::execute<>()
@ 0x2b485b4d5be1 _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v18executor5EventESt5dequeIS8_SaIS8_EEEEESC_SG_SC_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSN_FSK_T1_T2_ET3_T4_ENKUlPNS_11ProcessBaseEE_clESY_
@ 0x2b485c8ece87 process::ProcessManager::resume()
@ 0x2b485c90230f std::thread::_Impl<>::_M_run()
@ 0x2b485fe8ea60 (unknown)
@ 0x2b485fbc7184 start_thread
@ 0x2b48606fabed (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-1495123120-7337
Untagged: mesos-1495123120-7337:latest
Deleted: sha256:30f7d04957eb08b6b988a1629cba549ca14d8670bcecec633cf09f452c16e87a
Deleted: sha256:4a5f1504e04906510f146fe1074d870fbcc94afeba45726d73fd6bbf1a21066a
Deleted: sha256:aae092ed1c46af3598764244108a3f2d5d607386066326b21408045c21854110
Deleted: sha256:ef8a2795fff58a3f9c70a2d15f06fdabbd1a279bc8d5b83383e407455bce0ec3
Deleted: sha256:9e5391f53a05ce27016f928c2d35075c838a7d4ca84c16419516839355e67d66
Deleted: sha256:e2fa7a8be94967a389914f20c7672a7b4490f97f6ae90f08e70646365258ab10
Deleted: sha256:6dafa6548bc3d5691befe85e6b7642d6e540255c0f6e912bfa60fb4eb2d947db
Deleted: sha256:ef66d7a4156433e196759636eb3ccddd5ae3c2ffbe5f8a72b8afa860103d4e45
Deleted: sha256:dc620221ec98bc3187528ba4f81a6b2ef76925f4e40b780a443c0029003417dc
Deleted: sha256:3719de0af69073b1ffbf72549d58a6fd81f12004fbb74780c7b9ac1968c9e4bc
Deleted: sha256:295d6fd557b1413b3387d1ec763c9d2c251e304e0482fc29037c1508c6f7432c
Deleted: sha256:9676f603eeaa633cc82da71f5c211cac56e10979938660d8c1d4aa40a0cf0c36
Deleted: sha256:c2f3f882161e9077501594fd8563efa8f0fb59f070d8b7df376fea2b9d802d12
Deleted: sha256:5795cbeb096cc65fd7feeec8b257016174bf71db9803227be28f49ca03068513
Deleted: sha256:d90b9ff78bdadc32fe1f8f8ae2012d131bc4eb967f4dd9294364e2bcecdd023d
Deleted: sha256:c6ed0602cdf578f873243cba2c486a628e0c00f3a83e45f8da66ff5a052034d3
Deleted: sha256:597105f54c1e412abcede399bc51088b571aed9e74df1fd36129648af5bbc84b
Deleted: sha256:53aac00b5b95c58a91a0158127b44e6a8cadee7a43d0a01af04b1a2cfc61e191
Deleted: sha256:b5211e6255a98304fe12ee6e484887f149b452e71b8eb798b1686ac076603f5b
Deleted: sha256:25e747281fdc18fe779dd027f2d6a53400c538f1be3f47ee7d26496d4f1caa9b
Deleted: sha256:be9b8cc2f7324e8264b1497a3581a64ecacb6154b8bee59765e0d5d39df8c383
Deleted: sha256:2867050092c01510ef2d34cd345e5d1f62b1e93fdf2ad28ff6329e9426f5747e
Deleted: sha256:24d36ac577eda29c4c65f12b40e0e88777b55ca930ab60dd84caa6649359baa6
Deleted: sha256:d672fcdf1feff45875f59c76750f77feecdff808dfefb6d34e993c0fb7e74b73
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user yujie.jay@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(docker||Hadoop)&&(!ubuntu-us1)&&(!ubuntu-eu2) #3693
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,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)/3693/display/redirect?page=changes>