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/11/20 21:16:09 UTC

Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4479

See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4479/display/redirect?page=changes>

Changes:

[songzihao1990] Checkpoint and recover `ContainerConfig` in Mesos containerizer.

[songzihao1990] Backfilled required fields in TaskInfo in  MesosContainerizer* tests.

[songzihao1990] Added tests for recovering ContainerConfig.

[songzihao1990] Added checkpoint and recover capability for layers in provisioner.

[songzihao1990] Implemented pruneImages with a mark and sweep in docker store.

------------------------------------------
[...truncated 15.04 MB...]
3: I1120 21:16:02.856500 16020 hierarchical.cpp:1132] 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 f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 from framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000
3: I1120 21:16:02.856731 16013 master.cpp:9646] Removing executor 'default' with resources [] of framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000 on agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 at slave(342)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.856740 16003 slave.cpp:5539] Executor 'default' of framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000 exited with status 0
3: I1120 21:16:02.856822 16003 slave.cpp:5643] Cleaning up executor 'default' of framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000 at executor(133)@172.17.0.3:42842
3: I1120 21:16:02.857012 16008 gc.cpp:90] Scheduling '/tmp/MasterTest_FrameworkMessage_g4uRmU/slaves/f75eaf52-4287-48ca-9f05-49e6f34d1779-S0/frameworks/f75eaf52-4287-48ca-9f05-49e6f34d1779-0000/executors/default/runs/25e40b8e-c2cf-4938-a0f0-389e878ff7c5' for gc 6.99999008165333days in the future
3: I1120 21:16:02.857177 16003 slave.cpp:5750] Cleaning up framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000
3: I1120 21:16:02.857178 16008 gc.cpp:90] Scheduling '/tmp/MasterTest_FrameworkMessage_g4uRmU/slaves/f75eaf52-4287-48ca-9f05-49e6f34d1779-S0/frameworks/f75eaf52-4287-48ca-9f05-49e6f34d1779-0000/executors/default' for gc 6.99999007974519days in the future
3: I1120 21:16:02.857312 16011 status_update_manager.cpp:285] Closing status update streams for framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000
3: I1120 21:16:02.857360 16011 status_update_manager.cpp:531] Cleaning up status update stream for task 1 of framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000
3: I1120 21:16:02.857357 16016 gc.cpp:90] Scheduling '/tmp/MasterTest_FrameworkMessage_g4uRmU/slaves/f75eaf52-4287-48ca-9f05-49e6f34d1779-S0/frameworks/f75eaf52-4287-48ca-9f05-49e6f34d1779-0000' for gc 6.99999007765037days in the future
3: I1120 21:16:02.857381 16003 slave.cpp:883] Agent terminating
3: W1120 21:16:02.857409 16013 master.cpp:7474] Ignoring unknown exited executor 'default' of framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000 on agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 at slave(342)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.857530 16021 master.cpp:1311] Agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 at slave(342)@172.17.0.3:42842 (ed1b605d2ce0) disconnected
3: I1120 21:16:02.857547 16021 master.cpp:3370] Disconnecting agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 at slave(342)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.857554 16023 hierarchical.cpp:358] Removed framework f75eaf52-4287-48ca-9f05-49e6f34d1779-0000
3: I1120 21:16:02.857591 16021 master.cpp:3389] Deactivating agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 at slave(342)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.857676 16024 hierarchical.cpp:697] Agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0 deactivated
3: I1120 21:16:02.860533 16000 master.cpp:1153] Master terminating
3: I1120 21:16:02.861310 16022 hierarchical.cpp:633] Removed agent f75eaf52-4287-48ca-9f05-49e6f34d1779-S0
3: [       OK ] MasterTest.FrameworkMessage (66 ms)
3: [ RUN      ] MasterTest.MultipleExecutors
3: I1120 21:16:02.867480 16000 cluster.cpp:162] Creating default 'local' authorizer
3: I1120 21:16:02.870052 16018 master.cpp:448] Master e0c0f1e9-8206-4044-af99-844ce8b45c24 (ed1b605d2ce0) started on 172.17.0.3:42842
3: I1120 21:16:02.870085 16018 master.cpp:450] 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/9cExw2/credentials" --filter_gpu_resources="true" --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/9cExw2/master" --zk_session_timeout="10secs"
3: I1120 21:16:02.870378 16018 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1120 21:16:02.870384 16018 master.cpp:505] Master only allowing authenticated agents to register
3: I1120 21:16:02.870388 16018 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1120 21:16:02.870393 16018 credentials.hpp:37] Loading credentials for authentication from '/tmp/9cExw2/credentials'
3: I1120 21:16:02.870679 16018 master.cpp:555] Using default 'crammd5' authenticator
3: I1120 21:16:02.870826 16018 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1120 21:16:02.870967 16018 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1120 21:16:02.871079 16018 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1120 21:16:02.871177 16018 master.cpp:634] Authorization enabled
3: I1120 21:16:02.871330 16019 whitelist_watcher.cpp:77] No whitelist given
3: I1120 21:16:02.871331 16017 hierarchical.cpp:173] Initialized hierarchical allocator process
3: I1120 21:16:02.874301 16009 master.cpp:2215] Elected as the leading master!
3: I1120 21:16:02.874317 16009 master.cpp:1695] Recovering from registrar
3: I1120 21:16:02.874439 16013 registrar.cpp:347] Recovering registrar
3: I1120 21:16:02.875062 16013 registrar.cpp:391] Successfully fetched the registry (0B) in 587008ns
3: I1120 21:16:02.875187 16013 registrar.cpp:495] Applied 1 operations in 46186ns; attempting to update the registry
3: I1120 21:16:02.875728 16013 registrar.cpp:552] Successfully updated the registry in 483072ns
3: I1120 21:16:02.875833 16013 registrar.cpp:424] Successfully recovered registrar
3: I1120 21:16:02.876157 16005 master.cpp:1808] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1120 21:16:02.876194 16010 hierarchical.cpp:211] Skipping recovery of hierarchical allocator: nothing to recover
3: W1120 21:16:02.880805 16000 process.cpp:2754] Attempted to spawn already running process files@172.17.0.3:42842
3: I1120 21:16:02.881160 16000 cluster.cpp:448] Creating default 'local' authorizer
3: I1120 21:16:02.883688 16004 slave.cpp:262] Mesos agent started on (343)@172.17.0.3:42842
3: I1120 21:16:02.883715 16004 slave.cpp:263] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/MasterTest_MultipleExecutors_qzqPO6/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/MasterTest_MultipleExecutors_qzqPO6/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --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/MasterTest_MultipleExecutors_qzqPO6/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_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/MasterTest_MultipleExecutors_qzqPO6/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/MasterTest_MultipleExecutors_qzqPO6/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/MasterTest_MultipleExecutors_qzqPO6" --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/MasterTest_MultipleExecutors_8NQFFz" --zk_session_timeout="10secs"
3: I1120 21:16:02.884097 16004 credentials.hpp:86] Loading credential for authentication from '/tmp/MasterTest_MultipleExecutors_qzqPO6/credential'
3: I1120 21:16:02.884268 16004 slave.cpp:295] Agent using credential for: test-principal
3: I1120 21:16:02.884285 16004 credentials.hpp:37] Loading credentials for authentication from '/tmp/MasterTest_MultipleExecutors_qzqPO6/http_credentials'
3: W1120 21:16:02.884372 16000 process.cpp:2754] Attempted to spawn already running process version@172.17.0.3:42842
3: I1120 21:16:02.884516 16004 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1120 21:16:02.884691 16004 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readwrite'
3: I1120 21:16:02.885305 16000 sched.cpp:232] Version: 1.5.0
3: I1120 21:16:02.885777 16014 sched.cpp:336] New master detected at master@172.17.0.3:42842
3: I1120 21:16:02.885898 16014 sched.cpp:396] Authenticating with master master@172.17.0.3:42842
3: I1120 21:16:02.885913 16014 sched.cpp:403] Using default CRAM-MD5 authenticatee
3: I1120 21:16:02.886121 16019 authenticatee.cpp:121] Creating new client SASL connection
3: I1120 21:16:02.886392 16008 master.cpp:8306] Authenticating scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842
3: I1120 21:16:02.886226 16004 slave.cpp:593] Agent resources: [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1120 21:16:02.886435 16004 slave.cpp:601] Agent attributes: [  ]
3: I1120 21:16:02.886452 16004 slave.cpp:610] Agent hostname: ed1b605d2ce0
3: I1120 21:16:02.886484 16017 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(714)@172.17.0.3:42842
3: I1120 21:16:02.886602 16002 status_update_manager.cpp:177] Pausing sending status updates
3: I1120 21:16:02.886677 16009 authenticator.cpp:98] Creating new server SASL connection
3: I1120 21:16:02.886888 16003 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1120 21:16:02.886912 16003 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1120 21:16:02.887006 16012 authenticator.cpp:204] Received SASL authentication start
3: I1120 21:16:02.887050 16012 authenticator.cpp:326] Authentication requires more steps
3: I1120 21:16:02.887135 16022 authenticatee.cpp:259] Received SASL authentication step
3: I1120 21:16:02.887315 16015 authenticator.cpp:232] Received SASL authentication step
3: I1120 21:16:02.887356 16015 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ed1b605d2ce0' server FQDN: 'ed1b605d2ce0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I1120 21:16:02.887374 16015 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1120 21:16:02.887425 16015 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1120 21:16:02.887455 16015 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ed1b605d2ce0' server FQDN: 'ed1b605d2ce0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I1120 21:16:02.887470 16015 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1120 21:16:02.887477 16015 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1120 21:16:02.887498 16015 authenticator.cpp:318] Authentication success
3: I1120 21:16:02.887573 16023 authenticatee.cpp:299] Authentication success
3: I1120 21:16:02.887704 16023 master.cpp:8336] Successfully authenticated principal 'test-principal' at scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842
3: I1120 21:16:02.887745 16011 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(714)@172.17.0.3:42842
3: I1120 21:16:02.887899 16021 sched.cpp:502] Successfully authenticated with master master@172.17.0.3:42842
3: I1120 21:16:02.887917 16021 sched.cpp:824] Sending SUBSCRIBE call to master@172.17.0.3:42842
3: I1120 21:16:02.888077 16021 sched.cpp:857] Will retry registration in 1.493584326secs if necessary
3: I1120 21:16:02.888274 16010 master.cpp:2963] Received SUBSCRIBE call for framework 'default' at scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842
3: I1120 21:16:02.888293 16010 master.cpp:2280] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1120 21:16:02.888360 16007 state.cpp:64] Recovering state from '/tmp/MasterTest_MultipleExecutors_8NQFFz/meta'
3: I1120 21:16:02.888628 16007 status_update_manager.cpp:203] Recovering status update manager
3: I1120 21:16:02.888789 16016 master.cpp:3043] Subscribing framework default with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1120 21:16:02.888919 16009 slave.cpp:6441] Finished recovery
3: I1120 21:16:02.889355 16022 sched.cpp:751] Framework registered with e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.889441 16022 sched.cpp:765] Scheduler::registered took 68067ns
3: I1120 21:16:02.889515 16003 hierarchical.cpp:306] Added framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.889698 16013 status_update_manager.cpp:177] Pausing sending status updates
3: I1120 21:16:02.889710 16005 slave.cpp:1007] New master detected at master@172.17.0.3:42842
3: I1120 21:16:02.889721 16003 hierarchical.cpp:1457] Performed allocation for 0 agents in 86624ns
3: I1120 21:16:02.889822 16005 slave.cpp:1042] Detecting new master
3: I1120 21:16:02.894096 16021 slave.cpp:1069] Authenticating with master master@172.17.0.3:42842
3: I1120 21:16:02.894171 16021 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1120 21:16:02.894377 16020 authenticatee.cpp:121] Creating new client SASL connection
3: I1120 21:16:02.894623 16024 master.cpp:8306] Authenticating slave(343)@172.17.0.3:42842
3: I1120 21:16:02.894726 16014 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(715)@172.17.0.3:42842
3: I1120 21:16:02.894939 16010 authenticator.cpp:98] Creating new server SASL connection
3: I1120 21:16:02.895156 16019 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1120 21:16:02.895177 16019 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1120 21:16:02.895270 16018 authenticator.cpp:204] Received SASL authentication start
3: I1120 21:16:02.895313 16018 authenticator.cpp:326] Authentication requires more steps
3: I1120 21:16:02.895392 16008 authenticatee.cpp:259] Received SASL authentication step
3: I1120 21:16:02.895485 16007 authenticator.cpp:232] Received SASL authentication step
3: I1120 21:16:02.895514 16007 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ed1b605d2ce0' server FQDN: 'ed1b605d2ce0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
3: I1120 21:16:02.895521 16007 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1120 21:16:02.895555 16007 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1120 21:16:02.895570 16007 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'ed1b605d2ce0' server FQDN: 'ed1b605d2ce0' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
3: I1120 21:16:02.895578 16007 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1120 21:16:02.895582 16007 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1120 21:16:02.895594 16007 authenticator.cpp:318] Authentication success
3: I1120 21:16:02.895658 16004 authenticatee.cpp:299] Authentication success
3: I1120 21:16:02.895714 16002 master.cpp:8336] Successfully authenticated principal 'test-principal' at slave(343)@172.17.0.3:42842
3: I1120 21:16:02.895792 16016 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(715)@172.17.0.3:42842
3: I1120 21:16:02.895913 16004 slave.cpp:1161] Successfully authenticated with master master@172.17.0.3:42842
3: I1120 21:16:02.896133 16004 slave.cpp:1682] Will retry registration in 6.467993ms if necessary
3: I1120 21:16:02.896302 16015 master.cpp:6036] Received register agent message from slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.896332 16015 master.cpp:3872] Authorizing agent with principal 'test-principal'
3: I1120 21:16:02.896783 16013 master.cpp:6098] Authorized registration of agent at slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.896903 16013 master.cpp:6191] Registering agent at slave(343)@172.17.0.3:42842 (ed1b605d2ce0) with id e0c0f1e9-8206-4044-af99-844ce8b45c24-S0
3: I1120 21:16:02.897269 16003 registrar.cpp:495] Applied 1 operations in 74199ns; attempting to update the registry
3: I1120 21:16:02.897784 16003 registrar.cpp:552] Successfully updated the registry in 463872ns
3: I1120 21:16:02.897954 16020 master.cpp:6240] Admitted agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.898633 16014 slave.cpp:1207] Registered with master master@172.17.0.3:42842; given agent ID e0c0f1e9-8206-4044-af99-844ce8b45c24-S0
3: I1120 21:16:02.898721 16018 status_update_manager.cpp:184] Resuming sending status updates
3: I1120 21:16:02.898509 16020 master.cpp:6273] Registered agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0) with [{"name":"cpus","scalar":{"value":2.0},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"disk","scalar":{"value":1024.0},"type":"SCALAR"},{"name":"ports","ranges":{"range":[{"begin":31000,"end":32000}]},"type":"RANGES"}]
3: I1120 21:16:02.898851 16024 hierarchical.cpp:600] Added agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 (ed1b605d2ce0) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1120 21:16:02.899003 16014 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/MasterTest_MultipleExecutors_8NQFFz/meta/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/slave.info'
3: I1120 21:16:02.899415 16014 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1120 21:16:02.899624 16008 master.cpp:7085] Received update of agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0) with total oversubscribed resources {}
3: I1120 21:16:02.899816 16008 master.cpp:7103] Ignoring update on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0) as it reports no changes
3: I1120 21:16:02.900043 16024 hierarchical.cpp:1457] Performed allocation for 1 agents in 1.016547ms
3: I1120 21:16:02.900501 16007 master.cpp:8136] Sending 1 offers to framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 (default) at scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842
3: I1120 21:16:02.901016 16012 sched.cpp:921] Scheduler::resourceOffers took 111194ns
3: I1120 21:16:02.903064 16015 master.cpp:10045] Removing offer e0c0f1e9-8206-4044-af99-844ce8b45c24-O0
3: I1120 21:16:02.903199 16015 master.cpp:4230] Processing ACCEPT call for offers: [ e0c0f1e9-8206-4044-af99-844ce8b45c24-O0 ] on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0) for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 (default) at scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842
3: I1120 21:16:02.903290 16015 master.cpp:3599] Authorizing framework principal 'test-principal' to launch task 1
3: I1120 21:16:02.903458 16015 master.cpp:3599] Authorizing framework principal 'test-principal' to launch task 2
3: W1120 21:16:02.904932 16023 validation.cpp:1391] Executor 'executor-1' for task '1' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
3: W1120 21:16:02.904956 16023 validation.cpp:1403] Executor 'executor-1' for task '1' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
3: I1120 21:16:02.905290 16023 master.cpp:10793] Adding task 1 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.905570 16023 master.cpp:4978] Launching task 1 of framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 (default) at scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.905959 16021 slave.cpp:1803] Got assigned task '1' for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: W1120 21:16:02.906384 16023 validation.cpp:1391] Executor 'executor-2' for task '2' uses less CPUs (None) than the minimum required (0.01). Please update your executor, as this will be mandatory in future releases.
3: W1120 21:16:02.906409 16023 validation.cpp:1403] Executor 'executor-2' for task '2' uses less memory (None) than the minimum required (32MB). Please update your executor, as this will be mandatory in future releases.
3: I1120 21:16:02.906461 16021 slave.cpp:2071] Authorizing task '1' for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.906512 16021 slave.cpp:7262] Authorizing framework principal 'test-principal' to launch task 1
3: I1120 21:16:02.906705 16023 master.cpp:10793] Adding task 2 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.907090 16018 slave.cpp:2239] Launching task '1' for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.906975 16023 master.cpp:4978] Launching task 2 of framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 (default) at scheduler-62ee4295-d92d-403e-afb5-1f4ebd2aab21@172.17.0.3:42842 with resources [{"allocation_info":{"role":"*"},"name":"cpus","scalar":{"value":1.0},"type":"SCALAR"},{"allocation_info":{"role":"*"},"name":"mem","scalar":{"value":512.0},"type":"SCALAR"}] on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 at slave(343)@172.17.0.3:42842 (ed1b605d2ce0)
3: I1120 21:16:02.907565 16018 paths.cpp:621] Trying to chown '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/88cb4cae-d834-41a4-97dd-4630e18ca74f' to user 'mesos'
3: I1120 21:16:02.907773 16018 slave.cpp:7736] Launching executor 'executor-1' of framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 with resources [] in work directory '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/88cb4cae-d834-41a4-97dd-4630e18ca74f'
3: I1120 21:16:02.907872 16014 hierarchical.cpp:1132] Recovered ports(allocated: *):[31000-32000]; disk(allocated: *):1024 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000], allocated: cpus(allocated: *):2; mem(allocated: *):1024) on agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 from framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.907939 16014 hierarchical.cpp:1178] Framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 filtered agent e0c0f1e9-8206-4044-af99-844ce8b45c24-S0 for 5secs
3: I1120 21:16:02.908146 16018 slave.cpp:2930] Launching container 88cb4cae-d834-41a4-97dd-4630e18ca74f for executor 'executor-1' of framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.908409 16018 slave.cpp:2467] Queued task '1' for executor 'executor-1' of framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.908633 16018 slave.cpp:1803] Got assigned task '2' for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.908949 16018 slave.cpp:958] Successfully attached '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/88cb4cae-d834-41a4-97dd-4630e18ca74f' to virtual path '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/latest'
3: I1120 21:16:02.908983 16018 slave.cpp:958] Successfully attached '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/88cb4cae-d834-41a4-97dd-4630e18ca74f' to virtual path '/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/latest'
3: I1120 21:16:02.909004 16018 slave.cpp:958] Successfully attached '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/88cb4cae-d834-41a4-97dd-4630e18ca74f' to virtual path '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-1/runs/88cb4cae-d834-41a4-97dd-4630e18ca74f'
3: I1120 21:16:02.909085 16018 slave.cpp:2071] Authorizing task '2' for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.909135 16018 slave.cpp:7262] Authorizing framework principal 'test-principal' to launch task 2
3: I1120 21:16:02.909765 16017 slave.cpp:2239] Launching task '2' for framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000
3: I1120 21:16:02.910075 16017 paths.cpp:621] Trying to chown '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-2/runs/f48b4b2a-c4ef-45fc-972a-8c77fc3663ec' to user 'mesos'
3: I1120 21:16:02.910228 16017 slave.cpp:7736] Launching executor 'executor-2' of framework e0c0f1e9-8206-4044-af99-844ce8b45c24-0000 with resources [] in work directory '/tmp/MasterTest_MultipleExecutors_8NQFFz/slaves/e0c0f1e9-8206-4044-af99-844ce8b45c24-S0/frameworks/e0c0f1e9-8206-4044-af99-844ce8b45c24-0000/executors/executor-2/runs/f48b4b2a-c4ef-45fc-972a-8c77fc3663ec'
3: *** Aborted at 1511212562 (unix time) try "date -d @1511212562" if you are using GNU date ***
3: PC: @     0x2aba82a6c82d (unknown)
3: W1120 21:16:02.910840 16024 process.cpp:2754] Attempted to spawn already running process version@172.17.0.3:42842
3: *** SIGSEGV (@0xc0) received by PID 16000 (TID 0x2aba8be94700) from PID 192; stack trace: ***
3: I1120 21:16:02.911026 16024 exec.cpp:162] Version: 1.5.0
3:     @     0x2aba7ec6f330 (unknown)
3:     @     0x2aba82a6c82d (unknown)
3: I1120 21:16:02.911336 16004 exec.cpp:212] Executor started at: executor(134)@172.17.0.3:42842 with pid 16000
3:     @           0xc4c428 os::getenv()
3:     @     0x2aba7a81e6eb mesos::internal::slave::executorEnvironment()
3:     @     0x2aba7a819d59 mesos::internal::slave::Slave::launchExecutor()
3:     @     0x2aba7a8153e7 mesos::internal::slave::Slave::__run()
3:     @     0x2aba7a91d267 _ZZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS_6FutureISt4listIbSaIbEEEERKNS1_13FrameworkInfoERKNS1_12ExecutorInfoERK6OptionINS1_8TaskInfoEERKSI_INS1_13TaskGroupInfoEESB_SE_SH_SM_SQ_EEvRKNS_3PIDIT_EEMSS_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_ENKUlRS9_RSC_RSF_RSK_RSO_PNS_11ProcessBaseEE_clES1D_S1E_S1F_S1G_S1H_S1J_
3:     @     0x2aba7a91d0c8 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEE6__callIvJOS1K_EJLm0ELm1ELm2ELm3ELm4ELm5EEEEST_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3:     @     0x2aba7a91cf96 _ZNSt5_BindIFZN7process8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS2_13FrameworkInfoERKNS2_12ExecutorInfoERK6OptionINS2_8TaskInfoEERKSJ_INS2_13TaskGroupInfoEESC_SF_SI_SN_SR_EEvRKNS0_3PIDIT_EEMST_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSA_RSD_RSG_RSL_RSP_PNS0_11ProcessBaseEE_SA_SD_SG_SL_SP_St12_PlaceholderILi1EEEEclIJS1K_EvEESX_DpOT_
3:     @     0x2aba7a91c92f _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEESt5_BindIFZNS0_8dispatchIN5mesos8internal5slave5SlaveERKNS0_6FutureISt4listIbSaIbEEEERKNS6_13FrameworkInfoERKNS6_12ExecutorInfoERK6OptionINS6_8TaskInfoEERKSN_INS6_13TaskGroupInfoEESG_SJ_SM_SR_SV_EEvRKNS0_3PIDIT_EEMSX_FvT0_T1_T2_T3_T4_EOT5_OT6_OT7_OT8_OT9_EUlRSE_RSH_RSK_RSP_RST_S2_E_SE_SH_SK_SP_ST_St12_PlaceholderILi1EEEEE9_M_invokeERKSt9_Any_dataS2_
3:     @     0x2aba7dfa0774 std::function<>::operator()()
3:     @     0x2aba7df84564 process::ProcessBase::visit()
3:     @     0x2aba7e032fee process::DispatchEvent::visit()
3:     @           0xb342d1 process::ProcessBase::serve()
3:     @     0x2aba7df81422 process::ProcessManager::resume()
3:     @     0x2aba7df91d91 process::ProcessManager::init_threads()::$_7::operator()()
3:     @     0x2aba7df91cd5 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_7vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
3:     @     0x2aba7df91ca5 std::_Bind_simple<>::operator()()
3:     @     0x2aba7df91c7c std::thread::_Impl<>::_M_run()
3:     @     0x2aba822c2a60 (unknown)
3:     @     0x2aba7ec67184 start_thread
3:     @     0x2aba82b2effd (unknown)
3/3 Test #3: MesosTests .......................***Exception: SegFault175.30 sec

67% tests passed, 1 tests failed out of 3

Total Test time (real) = 194.28 sec

The following tests FAILED:
	  3 - MesosTests (SEGFAULT)
Errors while running CTest
make[3]: *** [CMakeFiles/check] Error 8
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-1511210948-5450
Untagged: mesos-1511210948-5450:latest
Deleted: sha256:51d3329b3a295da995d6e602f56e6ab64797ec685c3347a05e6ca34d5d73be07
Deleted: sha256:a9806101d337359e7e2faa4669d2930341d461fb353b16a2276b5fb71272cff2
Deleted: sha256:04c8992a0bb46e1945fd2f99fc37a1a5b5f1460ae1d00121fb5599121b8b7542
Deleted: sha256:b4a87247d803d79155152e14cfd87ee87b671a8fe22abcb44af9c9b9be1c7a0d
Deleted: sha256:ad10b7010af96891d66c70b56b82caa655ec3b76f55f57bfd7da0531e04f82b9
Deleted: sha256:d098aee5d7169b95d2cecd0ded1b2e3033fe86465ae7b83cb9a4cc518a5e8e34
Deleted: sha256:09dcdbc1cd3cf129cda1e025763237b42915fb389546168e548387219070ab69
Deleted: sha256:696979d3e6e25a341c792ab376474fc9aeabd5a2a634be076ae7296f57eff093
Deleted: sha256:f663a0b8d5fb6a3d511163f29d5b12f659a0b8823d75436ab1f89093230f3594
Deleted: sha256:69a1d9a1e6b1c8cde212d890c7468207e6d920b7883a31dcfcc8e74600e31e2b
Deleted: sha256:10970e1219272c3c11fb3008afa8c64b3db3271aeac27d43616ecee70c0c0feb
Deleted: sha256:06401f1e3081ee5315426be008ee56c11751b5e1d76f164bb2bdfb943d8fde49
Deleted: sha256:d46f98f7642f2c62efdc634caf00bd0126f61b464141f9c2176aa8d73413b855
Deleted: sha256:a879ea861763c093f246b996256963c7a8ef99a2a774267c048a816b88df360e
Deleted: sha256:db6f18c25de96d567b57d396132fbc736b1ede0e3466c85227a661045764e044
Deleted: sha256:8a231f3f30592bd342e7027757213411079d647712e73663a5ae36cc6417f9a5
Deleted: sha256:f2406891eb5540074b675ae4c1ca3ba2444e078476a1cfee6f213ab82370c228
Deleted: sha256:2ba55ec875123cc36821d1437d9a4ef585876d06dd6ecebf856f6febeff45ca0
Deleted: sha256:41d82fef26443df191563717171978a80b6521543612c43f2163eb8183cd4061
Deleted: sha256:6fc674455079d7fe0869fd18bdecc997200bb2c3d2c5323a56193e072e39ca5a
Deleted: sha256:19af5f37fa0c6d500db1d2dd370dd6d7df6e562daedee679da8c46a65f90a4c3
Deleted: sha256:753f6a2282647ebd87733955934d737fc1846524d2077b9db2ffdee192a7122c
Deleted: sha256:c6a2a7bda1d5ba544284939da4a08f1af04e206c2cf92b73727dc452efa95c8b
Deleted: sha256:d6513f7432f59d913979b877a0d6e42728ef2f7ec3a8cf14eec61946273f1bac
Deleted: sha256:7d6e65b46ad1a2993bd4dde033a5455a30c954789cd2fe431af6804569af16d2
Deleted: sha256:ed08b86a85d2e894a41fc80eaa0b577332248e74d0567fdcc0a849979ef217b6
Deleted: sha256:62afe8d035fbc4909e423fd1b883d10567834cbcab4b1e6faca409fc22a4c38d
Deleted: sha256:c30c127fc68976c0e454e6ee3f19bc67eff5c66668f4aebfc979e29fc7536a7a
Deleted: sha256:4fb8e16ef6277b7c1eb7c2d35e3bba37a7d4fde14595d98bb393610ac5ced227
Deleted: sha256:b0b966cb7d33ec7af7527c99554540de2b8f9189bb2efd97a523d27e08782103
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com


Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4480

Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4480/display/redirect>