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/14 01:38:09 UTC
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4451
See <https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=clang,CONFIGURATION=--verbose%20--disable-libtool-wrappers%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4451/display/redirect?page=changes>
Changes:
[yujie.jay] Handled the resource conversion for new operations in master.
[songzihao1990] Added a test `CgroupsIsolatorTest.ROOT_CGROUPS_BlkioUsage`.
------------------------------------------
[...truncated 27.84 MB...]
3: I1114 01:38:01.034093 18277 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:38:01.035605 18266 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_sL3Rlm/meta'
3: I1114 01:38:01.035863 18273 status_update_manager.cpp:203] Recovering status update manager
3: I1114 01:38:01.036036 18285 containerizer.cpp:662] Recovering containerizer
3: I1114 01:38:01.037405 18274 provisioner.cpp:416] Provisioner recovery complete
3: I1114 01:38:01.037737 18277 slave.cpp:6432] Finished recovery
3: I1114 01:38:01.038458 18266 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:38:01.038501 18272 slave.cpp:1007] New master detected at master@172.17.0.4:42218
3: I1114 01:38:01.038553 18272 slave.cpp:1042] Detecting new master
3: I1114 01:38:01.042368 18267 process.cpp:3925] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/api/v1/resource_provider'
3: I1114 01:38:01.044190 18274 http.cpp:1185] HTTP POST for /slave(750)/api/v1/resource_provider from 172.17.0.4:35596
3: I1114 01:38:01.044797 18287 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:38:01.052511 18278 slave.cpp:883] Agent terminating
3: I1114 01:38:01.057657 18265 master.cpp:1151] Master terminating
3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1 (50 ms)
3: [ RUN ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
3: I1114 01:38:01.063501 18265 cluster.cpp:162] Creating default 'local' authorizer
3: I1114 01:38:01.066292 18276 master.cpp:448] Master 2258d378-4e87-49ff-bf59-557eb423861a (146ee66cea76) started on 172.17.0.4:42218
3: I1114 01:38:01.066325 18276 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/Y9TrLh/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/Y9TrLh/master" --zk_session_timeout="10secs"
3: I1114 01:38:01.066591 18276 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1114 01:38:01.066596 18276 master.cpp:505] Master only allowing authenticated agents to register
3: I1114 01:38:01.066601 18276 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1114 01:38:01.066604 18276 credentials.hpp:37] Loading credentials for authentication from '/tmp/Y9TrLh/credentials'
3: I1114 01:38:01.066903 18276 master.cpp:555] Using default 'crammd5' authenticator
3: I1114 01:38:01.067034 18276 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1114 01:38:01.067190 18276 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1114 01:38:01.067314 18276 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1114 01:38:01.067409 18276 master.cpp:634] Authorization enabled
3: I1114 01:38:01.067553 18284 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1114 01:38:01.067574 18275 whitelist_watcher.cpp:77] No whitelist given
3: I1114 01:38:01.070149 18287 master.cpp:2213] Elected as the leading master!
3: I1114 01:38:01.070165 18287 master.cpp:1693] Recovering from registrar
3: I1114 01:38:01.070269 18268 registrar.cpp:347] Recovering registrar
3: I1114 01:38:01.070859 18268 registrar.cpp:391] Successfully fetched the registry (0B) in 560896ns
3: I1114 01:38:01.071007 18268 registrar.cpp:495] Applied 1 operations in 41329ns; attempting to update the registry
3: I1114 01:38:01.071521 18268 registrar.cpp:552] Successfully updated the registry in 461056ns
3: I1114 01:38:01.071617 18268 registrar.cpp:424] Successfully recovered registrar
3: I1114 01:38:01.071923 18286 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1114 01:38:01.071985 18288 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1114 01:38:01.076634 18265 process.cpp:3178] Attempted to spawn already running process files@172.17.0.4:42218
3: I1114 01:38:01.077483 18265 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1114 01:38:01.077975 18265 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1114 01:38:01.078091 18265 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1114 01:38:01.078124 18265 provisioner.cpp:255] Using default backend 'copy'
3: I1114 01:38:01.079885 18265 cluster.cpp:448] Creating default 'local' authorizer
3: I1114 01:38:01.081717 18288 slave.cpp:262] Mesos agent started on (751)@172.17.0.4:42218
3: I1114 01:38:01.081753 18288 slave.cpp:263] Flags at startup: --acls="" --agent_features="capabilities {
3: type: MULTI_ROLE
3: }
3: capabilities {
3: type: HIERARCHICAL_ROLE
3: }
3: capabilities {
3: type: RESERVATION_REFINEMENT
3: }
3: capabilities {
3: type: RESOURCE_PROVIDER
3: }
3: " --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --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_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/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_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/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_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU" --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_ResourceProviderManagerHttpApiTest_ConvertResources_0_pSMVYA" --zk_session_timeout="10secs"
3: I1114 01:38:01.082270 18288 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/credential'
3: I1114 01:38:01.082433 18288 slave.cpp:295] Agent using credential for: test-principal
3: I1114 01:38:01.082453 18288 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IUPqcU/http_credentials'
3: I1114 01:38:01.082734 18288 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
3: I1114 01:38:01.082885 18288 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
3: I1114 01:38:01.083092 18288 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1114 01:38:01.083211 18288 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1114 01:38:01.084640 18288 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: I1114 01:38:01.084822 18288 slave.cpp:601] Agent attributes: [ ]
3: I1114 01:38:01.084831 18288 slave.cpp:610] Agent hostname: 146ee66cea76
3: I1114 01:38:01.084962 18279 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:38:01.086391 18271 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_pSMVYA/meta'
3: I1114 01:38:01.086654 18286 status_update_manager.cpp:203] Recovering status update manager
3: I1114 01:38:01.086828 18278 containerizer.cpp:662] Recovering containerizer
3: I1114 01:38:01.088083 18270 provisioner.cpp:416] Provisioner recovery complete
3: I1114 01:38:01.088349 18279 slave.cpp:6432] Finished recovery
3: I1114 01:38:01.089072 18268 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 01:38:01.089095 18279 slave.cpp:1007] New master detected at master@172.17.0.4:42218
3: I1114 01:38:01.089187 18279 slave.cpp:1042] Detecting new master
3: I1114 01:38:01.091413 18271 slave.cpp:1069] Authenticating with master master@172.17.0.4:42218
3: I1114 01:38:01.091482 18271 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1114 01:38:01.091719 18267 authenticatee.cpp:121] Creating new client SASL connection
3: I1114 01:38:01.092008 18272 master.cpp:8285] Authenticating slave(751)@172.17.0.4:42218
3: I1114 01:38:01.092108 18286 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1381)@172.17.0.4:42218
3: I1114 01:38:01.092386 18281 authenticator.cpp:98] Creating new server SASL connection
3: I1114 01:38:01.092625 18276 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1114 01:38:01.092653 18276 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1114 01:38:01.092753 18275 authenticator.cpp:204] Received SASL authentication start
3: I1114 01:38:01.092806 18275 authenticator.cpp:326] Authentication requires more steps
3: I1114 01:38:01.092903 18284 authenticatee.cpp:259] Received SASL authentication step
3: I1114 01:38:01.093014 18280 authenticator.cpp:232] Received SASL authentication step
3: I1114 01:38:01.093050 18280 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '146ee66cea76' server FQDN: '146ee66cea76' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1114 01:38:01.093066 18280 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1114 01:38:01.093116 18280 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1114 01:38:01.093137 18280 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '146ee66cea76' server FQDN: '146ee66cea76' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1114 01:38:01.093149 18280 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:38:01.093155 18280 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:38:01.093168 18280 authenticator.cpp:318] Authentication success
3: I1114 01:38:01.093240 18289 authenticatee.cpp:299] Authentication success
3: I1114 01:38:01.093364 18285 master.cpp:8315] Successfully authenticated principal 'test-principal' at slave(751)@172.17.0.4:42218
3: I1114 01:38:01.093395 18283 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1381)@172.17.0.4:42218
3: I1114 01:38:01.093508 18278 slave.cpp:1161] Successfully authenticated with master master@172.17.0.4:42218
3: I1114 01:38:01.093755 18278 slave.cpp:1682] Will retry registration in 19.502206ms if necessary
3: I1114 01:38:01.094063 18269 master.cpp:6032] Received register agent message from slave(751)@172.17.0.4:42218 (146ee66cea76)
3: I1114 01:38:01.094094 18269 master.cpp:3870] Authorizing agent with principal 'test-principal'
3: I1114 01:38:01.094584 18266 master.cpp:6092] Authorized registration of agent at slave(751)@172.17.0.4:42218 (146ee66cea76)
3: I1114 01:38:01.094689 18266 master.cpp:6185] Registering agent at slave(751)@172.17.0.4:42218 (146ee66cea76) with id 2258d378-4e87-49ff-bf59-557eb423861a-S0
3: I1114 01:38:01.095041 18282 registrar.cpp:495] Applied 1 operations in 76432ns; attempting to update the registry
3: I1114 01:38:01.095656 18282 registrar.cpp:552] Successfully updated the registry in 545024ns
3: I1114 01:38:01.095841 18267 master.cpp:6232] Admitted agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76)
3: I1114 01:38:01.096536 18286 slave.cpp:1207] Registered with master master@172.17.0.4:42218; given agent ID 2258d378-4e87-49ff-bf59-557eb423861a-S0
3: I1114 01:38:01.096648 18275 status_update_manager.cpp:184] Resuming sending status updates
3: I1114 01:38:01.096403 18267 master.cpp:6263] Registered agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76) 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: I1114 01:38:01.096906 18281 hierarchical.cpp:593] Added agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 (146ee66cea76) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1114 01:38:01.096940 18286 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_pSMVYA/meta/slaves/2258d378-4e87-49ff-bf59-557eb423861a-S0/slave.info'
3: I1114 01:38:01.097280 18281 hierarchical.cpp:1450] Performed allocation for 1 agents in 187312ns
3: I1114 01:38:01.097405 18286 slave.cpp:1285] Forwarding total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 01:38:01.097458 18286 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1114 01:38:01.098091 18284 master.cpp:7051] Received update of agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 01:38:01.098155 18284 master.cpp:7064] Received update of agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76) with total oversubscribed resources {}
3: I1114 01:38:01.098347 18284 master.cpp:7082] Ignoring update on agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76) as it reports no changes
3: I1114 01:38:01.098448 18273 http_connection.hpp:221] New endpoint detected at http://172.17.0.4:42218/slave(751)/api/v1/resource_provider
3: I1114 01:38:01.100054 18279 http_connection.hpp:277] Connected with the remote endpoint at http://172.17.0.4:42218/slave(751)/api/v1/resource_provider
3: I1114 01:38:01.100814 18286 http_connection.hpp:129] Sending 1 call to http://172.17.0.4:42218/slave(751)/api/v1/resource_provider
3: I1114 01:38:01.101624 18270 process.cpp:3925] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 01:38:01.102689 18266 http.cpp:1185] HTTP POST for /slave(751)/api/v1/resource_provider from 172.17.0.4:35598
3: I1114 01:38:01.103005 18268 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:38:01.105355 18278 http_connection.hpp:129] Sending 3 call to http://172.17.0.4:42218/slave(751)/api/v1/resource_provider
3: I1114 01:38:01.106308 18281 process.cpp:3925] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 01:38:01.107276 18280 http.cpp:1185] HTTP POST for /slave(751)/api/v1/resource_provider from 172.17.0.4:35600
3: I1114 01:38:01.107718 18286 slave.cpp:6719] Handling resource provider message 'UPDATE_TOTAL_RESOURCES: 34e42b99-270a-41a0-9913-777d4b2c5c4e disk[RAW]:200'
3: I1114 01:38:01.107841 18286 slave.cpp:6764] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:38:01.108685 18274 master.cpp:7051] Received update of agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:38:01.110018 18265 scheduler.cpp:190] Version: 1.5.0
3: I1114 01:38:01.110327 18288 scheduler.cpp:313] Using default 'basic' HTTP authenticatee
3: I1114 01:38:01.110407 18273 hierarchical.cpp:660] Agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 (146ee66cea76) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:38:01.110759 18272 scheduler.cpp:496] New master detected at master@172.17.0.4:42218
3: I1114 01:38:01.110762 18273 hierarchical.cpp:1450] Performed allocation for 1 agents in 163717ns
3: I1114 01:38:01.110783 18272 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master
3: I1114 01:38:01.112200 18289 scheduler.cpp:387] Connected with the master at http://172.17.0.4:42218/master/api/v1/scheduler
3: I1114 01:38:01.113152 18268 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.4:42218/master/api/v1/scheduler
3: I1114 01:38:01.114055 18271 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:38:01.115059 18283 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:35602
3: I1114 01:38:01.115291 18283 master.cpp:2613] Received subscription request for HTTP framework 'default'
3: I1114 01:38:01.115334 18283 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1114 01:38:01.115797 18277 master.cpp:2748] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1114 01:38:01.116519 18274 hierarchical.cpp:303] Added framework 2258d378-4e87-49ff-bf59-557eb423861a-0000
3: I1114 01:38:01.117022 18271 scheduler.cpp:741] Enqueuing event SUBSCRIBED received from http://172.17.0.4:42218/master/api/v1/scheduler
3: I1114 01:38:01.117378 18271 scheduler.cpp:741] Enqueuing event HEARTBEAT received from http://172.17.0.4:42218/master/api/v1/scheduler
3: I1114 01:38:01.117868 18274 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.219819ms
3: I1114 01:38:01.118403 18281 master.cpp:8115] Sending 1 offers to framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 (default)
3: I1114 01:38:01.120007 18266 scheduler.cpp:741] Enqueuing event OFFERS received from http://172.17.0.4:42218/master/api/v1/scheduler
3: I1114 01:38:01.121301 18289 scheduler.cpp:249] Sending ACCEPT call to http://172.17.0.4:42218/master/api/v1/scheduler
3: I1114 01:38:01.122547 18288 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:38:01.123473 18279 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.4:35604
3: I1114 01:38:01.124495 18279 master.cpp:10017] Removing offer 2258d378-4e87-49ff-bf59-557eb423861a-O0
3: I1114 01:38:01.124598 18279 master.cpp:4228] Processing ACCEPT call for offers: [ 2258d378-4e87-49ff-bf59-557eb423861a-O0 ] on agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76) for framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 (default)
3: I1114 01:38:01.125241 18279 master.cpp:5293] Processing CREATE_BLOCK operation with source disk(allocated: *)[RAW]:200 from framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 (default) to agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76)
3: I1114 01:38:01.125807 18279 master.cpp:9900] Sending offer operation Í«Ï·¦ôMÙ$[]:ä¨ to agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 at slave(751)@172.17.0.4:42218 (146ee66cea76)
3: I1114 01:38:01.126850 18287 hierarchical.cpp:1125] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200, allocated: disk(allocated: *)[RAW]:200) on agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 from framework 2258d378-4e87-49ff-bf59-557eb423861a-0000
3: I1114 01:38:01.126938 18287 hierarchical.cpp:1171] Framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 filtered agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 for 5secs
3: I1114 01:38:01.128521 18288 http_connection.hpp:129] Sending 2 call to http://172.17.0.4:42218/slave(751)/api/v1/resource_provider
3: I1114 01:38:01.129139 18284 process.cpp:3925] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 01:38:01.168615 18279 http.cpp:1185] HTTP POST for /slave(751)/api/v1/resource_provider from 172.17.0.4:35600
3: I1114 01:38:01.169548 18267 slave.cpp:6719] Handling resource provider message 'UPDATE_OFFER_OPERATION_STATUS: {"framework_id":{"value":"2258d378-4e87-49ff-bf59-557eb423861a-0000"},"status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"34e42b99-270a-41a0-9913-777d4b2c5c4e"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"latest_status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"34e42b99-270a-41a0-9913-777d4b2c5c4e"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"operation_uuid":"zavPt6b0TdmBJFtdOuSoEA=="}'
3: I1114 01:38:01.169911 18267 slave.cpp:6893] Updating the state of offer operation '' (uuid: Í«Ï·¦ôMÙ$[]:ä¨) of framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1114 01:38:01.170297 18267 slave.cpp:6817] Forwarding status update of offer operation '' (uuid: cdabcfb7-a6f4-4dd9-8124-5b5d3ae4a810) for framework 2258d378-4e87-49ff-bf59-557eb423861a-0000
3: I1114 01:38:01.170882 18270 master.cpp:9698] Updating the state of offer operation '' (uuid: cdabcfb7-a6f4-4dd9-8124-5b5d3ae4a810) of framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: F1114 01:38:01.171216 18270 master.cpp:11027] CHECK_SOME(resources): cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200 does not contain disk(allocated: *)[RAW]:200
3: *** Check failure stack trace: ***
3: @ 0x2add7320ea53 google::LogMessage::SendToLog()
3: @ 0x2add7320eecf google::LogMessage::Flush()
3: @ 0x2add7321295d google::LogMessageFatal::~LogMessageFatal()
3: I1114 01:38:01.172716 18285 hierarchical.cpp:849] Updated allocation of framework 2258d378-4e87-49ff-bf59-557eb423861a-0000 on agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 from disk(allocated: *)[RAW]:200 to disk(allocated: *)[BLOCK]:200
3: I1114 01:38:01.173086 18285 hierarchical.cpp:1125] Recovered disk(allocated: *)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[BLOCK]:200, allocated: {}) on agent 2258d378-4e87-49ff-bf59-557eb423861a-S0 from framework 2258d378-4e87-49ff-bf59-557eb423861a-0000
3: @ 0xaa32b7 _CheckFatal::~_CheckFatal()
3: I1114 01:38:01.182101 18278 hierarchical.cpp:1450] Performed allocation for 1 agents in 1.40907ms
3: @ 0x2add6ff1a77b mesos::internal::master::Slave::apply()
3: @ 0x2add6ff10014 mesos::internal::master::Master::updateOfferOperation()
3: @ 0x2add6fec104d mesos::internal::master::Master::offerOperationStatusUpdate()
3: @ 0x2add70031d74 ProtobufProcess<>::_handlerM<>()
3: @ 0x2add7003285c _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3: @ 0x2add70032753 _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEEclIJSD_SF_EvEET0_DpOT_
3: @ 0x2add700324d7 std::_Function_handler<>::_M_invoke()
3: @ 0xcedb00 std::function<>::operator()()
3: @ 0x2add6ff37786 ProtobufProcess<>::visit()
3: @ 0x2add6feceee5 mesos::internal::master::Master::_visit()
3: @ 0x2add6fece504 mesos::internal::master::Master::visit()
3: @ 0x2add6fecf0f7 mesos::internal::master::Master::visit()
3: @ 0x2add70010e7e process::MessageEvent::visit()
3: @ 0xaead01 process::ProcessBase::serve()
3: @ 0x2add72740772 process::ProcessManager::resume()
3: @ 0x2add72750801 process::ProcessManager::init_threads()::$_9::operator()()
3: @ 0x2add72750745 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_9vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
3: @ 0x2add72750715 std::_Bind_simple<>::operator()()
3: @ 0x2add727506ec std::thread::_Impl<>::_M_run()
3: @ 0x2add77166a60 (unknown)
3: @ 0x2add7343b184 start_thread
3: @ 0x2add779d2ffd (unknown)
3/3 Test #3: MesosTests .......................***Exception: Other293.46 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 329.79 sec
The following tests FAILED:
3 - MesosTests (OTHER_FAULT)
Errors while running CTest
make[3]: Leaving directory `/mesos/build'
make[3]: *** [CMakeFiles/check] Error 8
make[2]: Leaving directory `/mesos/build'
make[2]: *** [CMakeFiles/check.dir/all] Error 2
make[1]: Leaving directory `/mesos/build'
make[1]: *** [CMakeFiles/check.dir/rule] Error 2
make: *** [check] Error 2
+ docker rmi mesos-1510621675-10365
Untagged: mesos-1510621675-10365:latest
Deleted: sha256:0fc27debaeab30d7692550f957ce7f20d35fa4fff4b2cb97d890c778c283313b
Deleted: sha256:ab0d6ef39f7a8ede6d29f94b2b8827987562088f24fd667707c6c6ab15ca384b
Deleted: sha256:7408316734af348fa7850da8231cd39ba0b1ec81f8c760557fd03835a0a600c2
Deleted: sha256:3533b7ccce091de81c028b2be3ebdcffb20d50069a1df5bec7518e85af61b645
Deleted: sha256:6a1786c3d5b6059cd950a277d2d047cc3702855be1bc83de3e0b3debbe0440d4
Deleted: sha256:c065b9d9910a7b529eb9da32585e7915793e2d06ebcbc6192631830c6eb30ff0
Deleted: sha256:624b93fd17f488727e5b9ef6c91e290e352d66b654554ad0d37a43e181968682
Deleted: sha256:04290ea251d6da09ac916c316eb53ae80966217d9117aedefa1f042896251626
Deleted: sha256:945aeff80f764b6ded60124ad7d6b800a0ce8a16ef92d884d688b427a3d8bd18
Deleted: sha256:08625439a5410fdbddbd5ceed7e2fd5547a0ac952b7e3bbeb872c376e083c5de
Deleted: sha256:f5c53d5f1819c9d0a1041b83430367fb84444c870bef289b78cab5e276983a71
Deleted: sha256:d014ccc0a28bb5dd5727a19bd9d14037543566a78a039b0bd69e3851fce582c3
Deleted: sha256:60e65c6538fd42b9b9b5b1b1f190c28f9319c42dd94cf1440b7893b7dcd48742
Deleted: sha256:d1e0183d980e9b331a63a4ac171a35829dc9570ee61b25d005b8126859f92de1
Deleted: sha256:0c24391acf078bb43793ef0d4033d31bf26ec8cf57d05dd78d04834d5adf15ea
Deleted: sha256:f7cff153b09a8f7d7ca54270301205554f52e66b9441ceea888a1af93fcf55b2
Deleted: sha256:cb025ad1f6ad581e827f95ffe1321184f112c3ed2e7812009b15f80b1ccf574f
Deleted: sha256:c2ecf4414c500dcbbf32bfe993075c113ae082fefff790bfd2f79f46c8f7efcb
Deleted: sha256:671c893f35c44e6468140c741fcf895bc96e9d4e92d740d4f335e08940b22311
Deleted: sha256:b215f33ccb06b7e96d03000b1b8a8c2488918441b3a7c730b05bd353a43dc343
Deleted: sha256:572ebabe350a06fb1d9397e1e8b71a20af9c99e45dbf33b59e35aec29e0a62e9
Deleted: sha256:3db847f9f016b2d916ed8ad1dd09ebd940cc7ece3d33c390e0cee144f612f221
Deleted: sha256:139bfb2b0121ed0aa9c046c2afef5ef881842a4531c118750c6fe720d6e219ff
Deleted: sha256:d0594c51f4507096e8867c913f12f797e5315e82c5f6df55d0ccf5b86213cf60
Deleted: sha256:06fe14ce3791deae5386cb81e0a00cd3d6e02f50f1aab959592103ff0d0356f5
Deleted: sha256:3174c75415124bbe3676378d808c4928f848cd4731e453e42f0597524f5e444f
Deleted: sha256:0573f8f3b114bd2ddf61b3ed17f45336be6a4a1f1f321ae1fc810854585a461f
Deleted: sha256:1f3d7ac745c837862adb803527aaa36ec0067b0b1bc8b2243b561e935990e9ed
Deleted: sha256:977aee11d640de705e152823f0c84bd7f739f06e5c3a1b0f73d31dcff4f4bc15
Deleted: sha256:91df8953de44efbc5baf2f03494a79a42b97c2eb2268e20086d6226bff23a7ff
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user yujie.jay@gmail.com
Jenkins build is back to normal : Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4455
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%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4455/display/redirect?page=changes>
Build failed in Jenkins: Mesos-Buildbot » cmake,clang,--verbose --disable-libtool-wrappers --enable-libevent --enable-ssl,GLOG_v=1 MESOS_VERBOSE=1,ubuntu:14.04,(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23) #4452
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%20--enable-libevent%20--enable-ssl,ENVIRONMENT=GLOG_v=1%20MESOS_VERBOSE=1,OS=ubuntu%3A14.04,label_exp=(ubuntu)&&(!ubuntu-us1)&&(!ubuntu-eu2)&&(!qnode3)&&(!H23)/4452/display/redirect>
------------------------------------------
[...truncated 27.89 MB...]
3: I1114 02:43:26.944177 18287 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:43:26.946146 18286 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_bMEwDL/meta'
3: I1114 02:43:26.946534 18265 status_update_manager.cpp:203] Recovering status update manager
3: I1114 02:43:26.946774 18288 containerizer.cpp:662] Recovering containerizer
3: I1114 02:43:26.948195 18274 provisioner.cpp:416] Provisioner recovery complete
3: I1114 02:43:26.948624 18274 slave.cpp:6432] Finished recovery
3: I1114 02:43:26.949740 18265 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:43:26.949733 18282 slave.cpp:1007] New master detected at master@172.17.0.3:38928
3: I1114 02:43:26.949900 18282 slave.cpp:1042] Detecting new master
3: I1114 02:43:26.953953 18280 process.cpp:3925] Handling HTTP event for process 'slave(750)' with path: '/slave(750)/api/v1/resource_provider'
3: I1114 02:43:26.956470 18266 http.cpp:1185] HTTP POST for /slave(750)/api/v1/resource_provider from 172.17.0.3:39704
3: I1114 02:43:26.957031 18268 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 02:43:26.963726 18285 slave.cpp:883] Agent terminating
3: I1114 02:43:26.971169 18264 master.cpp:1151] Master terminating
3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1 (64 ms)
3: [ RUN ] ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
3: I1114 02:43:26.979354 18264 cluster.cpp:162] Creating default 'local' authorizer
3: I1114 02:43:26.983074 18267 master.cpp:448] Master 7b4e57ef-53f4-4165-9ddf-515e4bf492b9 (3f4a62735b4c) started on 172.17.0.3:38928
3: I1114 02:43:26.983124 18267 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/NGWNty/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/NGWNty/master" --zk_session_timeout="10secs"
3: I1114 02:43:26.983458 18267 master.cpp:499] Master only allowing authenticated frameworks to register
3: I1114 02:43:26.983467 18267 master.cpp:505] Master only allowing authenticated agents to register
3: I1114 02:43:26.983474 18267 master.cpp:511] Master only allowing authenticated HTTP frameworks to register
3: I1114 02:43:26.983479 18267 credentials.hpp:37] Loading credentials for authentication from '/tmp/NGWNty/credentials'
3: I1114 02:43:26.983899 18267 master.cpp:555] Using default 'crammd5' authenticator
3: I1114 02:43:26.984081 18267 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
3: I1114 02:43:26.984258 18267 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
3: I1114 02:43:26.984426 18267 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
3: I1114 02:43:26.984658 18267 master.cpp:634] Authorization enabled
3: I1114 02:43:26.984859 18280 hierarchical.cpp:171] Initialized hierarchical allocator process
3: I1114 02:43:26.984900 18277 whitelist_watcher.cpp:77] No whitelist given
3: I1114 02:43:26.987910 18278 master.cpp:2213] Elected as the leading master!
3: I1114 02:43:26.987932 18278 master.cpp:1693] Recovering from registrar
3: I1114 02:43:26.988057 18283 registrar.cpp:347] Recovering registrar
3: I1114 02:43:26.988684 18283 registrar.cpp:391] Successfully fetched the registry (0B) in 584960ns
3: I1114 02:43:26.988807 18283 registrar.cpp:495] Applied 1 operations in 41999ns; attempting to update the registry
3: I1114 02:43:26.989468 18283 registrar.cpp:552] Successfully updated the registry in 598016ns
3: I1114 02:43:26.989603 18283 registrar.cpp:424] Successfully recovered registrar
3: I1114 02:43:26.990031 18270 master.cpp:1806] Recovered 0 agents from the registry (129B); allowing 10mins for agents to re-register
3: I1114 02:43:26.990080 18265 hierarchical.cpp:209] Skipping recovery of hierarchical allocator: nothing to recover
3: W1114 02:43:26.995997 18264 process.cpp:3178] Attempted to spawn already running process files@172.17.0.3:38928
3: I1114 02:43:26.997256 18264 containerizer.cpp:301] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1114 02:43:26.997828 18264 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
3: W1114 02:43:26.997967 18264 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
3: I1114 02:43:26.998003 18264 provisioner.cpp:255] Using default backend 'copy'
3: I1114 02:43:27.000257 18264 cluster.cpp:448] Creating default 'local' authorizer
3: I1114 02:43:27.002749 18265 slave.cpp:262] Mesos agent started on (751)@172.17.0.3:38928
3: I1114 02:43:27.002799 18265 slave.cpp:263] Flags at startup: --acls="" --agent_features="capabilities {
3: type: MULTI_ROLE
3: }
3: capabilities {
3: type: HIERARCHICAL_ROLE
3: }
3: capabilities {
3: type: RESERVATION_REFINEMENT
3: }
3: capabilities {
3: type: RESOURCE_PROVIDER
3: }
3: " --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/store/appc" --authenticate_http_executors="true" --authenticate_http_readonly="true" --authenticate_http_readwrite="false" --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_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/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/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_secret_key="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/executor_secret_key" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/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_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/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_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp" --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_ResourceProviderManagerHttpApiTest_ConvertResources_0_LzdKbu" --zk_session_timeout="10secs"
3: I1114 02:43:27.003717 18265 credentials.hpp:86] Loading credential for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/credential'
3: I1114 02:43:27.003940 18265 slave.cpp:295] Agent using credential for: test-principal
3: I1114 02:43:27.003970 18265 credentials.hpp:37] Loading credentials for authentication from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_Y3WHTp/http_credentials'
3: I1114 02:43:27.004287 18265 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-executor'
3: I1114 02:43:27.004415 18265 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-executor'
3: I1114 02:43:27.004647 18265 http.cpp:1045] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1114 02:43:27.004758 18265 http.cpp:1066] Creating default 'jwt' HTTP authenticator for realm 'mesos-agent-readonly'
3: I1114 02:43:27.006423 18265 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: I1114 02:43:27.006662 18265 slave.cpp:601] Agent attributes: [ ]
3: I1114 02:43:27.006675 18265 slave.cpp:610] Agent hostname: 3f4a62735b4c
3: I1114 02:43:27.006918 18275 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:43:27.008361 18283 state.cpp:64] Recovering state from '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_LzdKbu/meta'
3: I1114 02:43:27.008795 18281 status_update_manager.cpp:203] Recovering status update manager
3: I1114 02:43:27.009030 18270 containerizer.cpp:662] Recovering containerizer
3: I1114 02:43:27.010911 18273 provisioner.cpp:416] Provisioner recovery complete
3: I1114 02:43:27.011324 18268 slave.cpp:6432] Finished recovery
3: I1114 02:43:27.012399 18265 slave.cpp:1007] New master detected at master@172.17.0.3:38928
3: I1114 02:43:27.012423 18269 status_update_manager.cpp:177] Pausing sending status updates
3: I1114 02:43:27.012495 18265 slave.cpp:1042] Detecting new master
3: I1114 02:43:27.022431 18282 slave.cpp:1069] Authenticating with master master@172.17.0.3:38928
3: I1114 02:43:27.022552 18282 slave.cpp:1078] Using default CRAM-MD5 authenticatee
3: I1114 02:43:27.022900 18281 authenticatee.cpp:121] Creating new client SASL connection
3: I1114 02:43:27.023373 18274 master.cpp:8285] Authenticating slave(751)@172.17.0.3:38928
3: I1114 02:43:27.023582 18271 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1384)@172.17.0.3:38928
3: I1114 02:43:27.023967 18288 authenticator.cpp:98] Creating new server SASL connection
3: I1114 02:43:27.024322 18280 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
3: I1114 02:43:27.024366 18280 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
3: I1114 02:43:27.024518 18280 authenticator.cpp:204] Received SASL authentication start
3: I1114 02:43:27.024600 18280 authenticator.cpp:326] Authentication requires more steps
3: I1114 02:43:27.024756 18266 authenticatee.cpp:259] Received SASL authentication step
3: I1114 02:43:27.024960 18277 authenticator.cpp:232] Received SASL authentication step
3: I1114 02:43:27.025017 18277 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3f4a62735b4c' server FQDN: '3f4a62735b4c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
3: I1114 02:43:27.025044 18277 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
3: I1114 02:43:27.025112 18277 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
3: I1114 02:43:27.025180 18277 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '3f4a62735b4c' server FQDN: '3f4a62735b4c' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
3: I1114 02:43:27.025202 18277 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1114 02:43:27.025212 18277 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1114 02:43:27.025241 18277 authenticator.cpp:318] Authentication success
3: I1114 02:43:27.025406 18270 authenticatee.cpp:299] Authentication success
3: I1114 02:43:27.025472 18267 master.cpp:8315] Successfully authenticated principal 'test-principal' at slave(751)@172.17.0.3:38928
3: I1114 02:43:27.025579 18278 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1384)@172.17.0.3:38928
3: I1114 02:43:27.025871 18284 slave.cpp:1161] Successfully authenticated with master master@172.17.0.3:38928
3: I1114 02:43:27.026243 18284 slave.cpp:1682] Will retry registration in 14.722655ms if necessary
3: I1114 02:43:27.026558 18279 master.cpp:6032] Received register agent message from slave(751)@172.17.0.3:38928 (3f4a62735b4c)
3: I1114 02:43:27.026612 18279 master.cpp:3870] Authorizing agent with principal 'test-principal'
3: I1114 02:43:27.027230 18275 master.cpp:6092] Authorized registration of agent at slave(751)@172.17.0.3:38928 (3f4a62735b4c)
3: I1114 02:43:27.027406 18275 master.cpp:6185] Registering agent at slave(751)@172.17.0.3:38928 (3f4a62735b4c) with id 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0
3: I1114 02:43:27.027920 18287 registrar.cpp:495] Applied 1 operations in 110855ns; attempting to update the registry
3: I1114 02:43:27.028699 18287 registrar.cpp:552] Successfully updated the registry in 686848ns
3: I1114 02:43:27.029039 18282 master.cpp:6232] Admitted agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c)
3: I1114 02:43:27.030211 18274 slave.cpp:1207] Registered with master master@172.17.0.3:38928; given agent ID 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0
3: I1114 02:43:27.030028 18282 master.cpp:6263] Registered agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c) 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: I1114 02:43:27.030364 18286 status_update_manager.cpp:184] Resuming sending status updates
3: I1114 02:43:27.030510 18281 hierarchical.cpp:593] Added agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 (3f4a62735b4c) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
3: I1114 02:43:27.030710 18274 slave.cpp:1227] Checkpointing SlaveInfo to '/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_LzdKbu/meta/slaves/7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0/slave.info'
3: I1114 02:43:27.030959 18281 hierarchical.cpp:1450] Performed allocation for 1 agents in 227951ns
3: I1114 02:43:27.031344 18274 slave.cpp:1285] Forwarding total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 02:43:27.031460 18274 slave.cpp:1295] Forwarding total oversubscribed resources {}
3: I1114 02:43:27.032407 18274 master.cpp:7051] Received update of agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 02:43:27.032505 18274 master.cpp:7064] Received update of agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c) with total oversubscribed resources {}
3: I1114 02:43:27.032789 18274 master.cpp:7082] Ignoring update on agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c) as it reports no changes
3: I1114 02:43:27.032948 18272 http_connection.hpp:221] New endpoint detected at http://172.17.0.3:38928/slave(751)/api/v1/resource_provider
3: I1114 02:43:27.035121 18265 http_connection.hpp:277] Connected with the remote endpoint at http://172.17.0.3:38928/slave(751)/api/v1/resource_provider
3: I1114 02:43:27.036469 18280 http_connection.hpp:129] Sending 1 call to http://172.17.0.3:38928/slave(751)/api/v1/resource_provider
3: I1114 02:43:27.037612 18273 process.cpp:3925] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 02:43:27.039407 18275 http.cpp:1185] HTTP POST for /slave(751)/api/v1/resource_provider from 172.17.0.3:39706
3: I1114 02:43:27.039808 18269 manager.cpp:381] Subscribing resource provider {"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 02:43:27.043633 18278 http_connection.hpp:129] Sending 3 call to http://172.17.0.3:38928/slave(751)/api/v1/resource_provider
3: I1114 02:43:27.045075 18269 process.cpp:3925] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 02:43:27.046955 18281 http.cpp:1185] HTTP POST for /slave(751)/api/v1/resource_provider from 172.17.0.3:39708
3: I1114 02:43:27.047631 18285 slave.cpp:6719] Handling resource provider message 'UPDATE_TOTAL_RESOURCES: 38c9dcee-c1e7-40cb-8bfd-996c8be31beb disk[RAW]:200'
3: I1114 02:43:27.047801 18285 slave.cpp:6764] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 02:43:27.049073 18280 master.cpp:7051] Received update of agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c) with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 02:43:27.050693 18264 scheduler.cpp:190] Version: 1.5.0
3: I1114 02:43:27.050777 18266 hierarchical.cpp:660] Agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 (3f4a62735b4c) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 02:43:27.051049 18275 scheduler.cpp:313] Using default 'basic' HTTP authenticatee
3: I1114 02:43:27.051184 18266 hierarchical.cpp:1450] Performed allocation for 1 agents in 196530ns
3: I1114 02:43:27.051584 18287 scheduler.cpp:496] New master detected at master@172.17.0.3:38928
3: I1114 02:43:27.051628 18287 scheduler.cpp:505] Waiting for 0ns before initiating a re-(connection) attempt with the master
3: I1114 02:43:27.053709 18270 scheduler.cpp:387] Connected with the master at http://172.17.0.3:38928/master/api/v1/scheduler
3: I1114 02:43:27.055001 18284 scheduler.cpp:249] Sending SUBSCRIBE call to http://172.17.0.3:38928/master/api/v1/scheduler
3: I1114 02:43:27.057256 18266 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 02:43:27.059098 18277 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:39710
3: I1114 02:43:27.059494 18277 master.cpp:2613] Received subscription request for HTTP framework 'default'
3: I1114 02:43:27.059557 18277 master.cpp:2278] Authorizing framework principal 'test-principal' to receive offers for roles '{ * }'
3: I1114 02:43:27.060282 18280 master.cpp:2748] Subscribing framework 'default' with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1114 02:43:27.061415 18272 hierarchical.cpp:303] Added framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000
3: I1114 02:43:27.062353 18283 scheduler.cpp:741] Enqueuing event SUBSCRIBED received from http://172.17.0.3:38928/master/api/v1/scheduler
3: I1114 02:43:27.062934 18283 scheduler.cpp:741] Enqueuing event HEARTBEAT received from http://172.17.0.3:38928/master/api/v1/scheduler
3: I1114 02:43:27.063763 18272 hierarchical.cpp:1450] Performed allocation for 1 agents in 2.158683ms
3: I1114 02:43:27.064606 18269 master.cpp:8115] Sending 1 offers to framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 (default)
3: I1114 02:43:27.067237 18284 scheduler.cpp:741] Enqueuing event OFFERS received from http://172.17.0.3:38928/master/api/v1/scheduler
3: I1114 02:43:27.069792 18285 scheduler.cpp:249] Sending ACCEPT call to http://172.17.0.3:38928/master/api/v1/scheduler
3: I1114 02:43:27.071691 18278 process.cpp:3925] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler'
3: I1114 02:43:27.073215 18288 http.cpp:1185] HTTP POST for /master/api/v1/scheduler from 172.17.0.3:39712
3: I1114 02:43:27.074936 18288 master.cpp:10017] Removing offer 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-O0
3: I1114 02:43:27.075117 18288 master.cpp:4228] Processing ACCEPT call for offers: [ 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-O0 ] on agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c) for framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 (default)
3: I1114 02:43:27.076304 18288 master.cpp:5293] Processing CREATE_BLOCK operation with source disk(allocated: *)[RAW]:200 from framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 (default) to agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c)
3: I1114 02:43:27.077252 18288 master.cpp:9900] Sending offer operation Mâ:LôµÙeÁ®c to agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 at slave(751)@172.17.0.3:38928 (3f4a62735b4c)
3: I1114 02:43:27.079383 18284 hierarchical.cpp:1125] Recovered cpus(allocated: *):2; mem(allocated: *):1024; disk(allocated: *):1024; ports(allocated: *):[31000-32000] (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200, allocated: disk(allocated: *)[RAW]:200) on agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 from framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000
3: I1114 02:43:27.079499 18284 hierarchical.cpp:1171] Framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 filtered agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 for 5secs
3: I1114 02:43:27.082118 18278 http_connection.hpp:129] Sending 2 call to http://172.17.0.3:38928/slave(751)/api/v1/resource_provider
3: I1114 02:43:27.083732 18269 process.cpp:3925] Handling HTTP event for process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 02:43:27.122825 18288 http.cpp:1185] HTTP POST for /slave(751)/api/v1/resource_provider from 172.17.0.3:39708
3: I1114 02:43:27.123867 18271 slave.cpp:6719] Handling resource provider message 'UPDATE_OFFER_OPERATION_STATUS: {"framework_id":{"value":"7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000"},"status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"38c9dcee-c1e7-40cb-8bfd-996c8be31beb"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"latest_status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"38c9dcee-c1e7-40cb-8bfd-996c8be31beb"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"operation_uuid":"Bk3ikjqJTPSQDbXZZcGuYw=="}'
3: I1114 02:43:27.124411 18271 slave.cpp:6893] Updating the state of offer operation '' (uuid: Mâ:LôµÙeÁ®c) of framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1114 02:43:27.124999 18271 slave.cpp:6817] Forwarding status update of offer operation '' (uuid: 064de292-3a89-4cf4-900d-b5d965c1ae63) for framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000
3: I1114 02:43:27.125789 18266 master.cpp:9698] Updating the state of offer operation '' (uuid: 064de292-3a89-4cf4-900d-b5d965c1ae63) of framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 (latest state: OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: F1114 02:43:27.126336 18266 master.cpp:11027] CHECK_SOME(resources): cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200 does not contain disk(allocated: *)[RAW]:200
3: *** Check failure stack trace: ***
3: @ 0x2af470402a53 google::LogMessage::SendToLog()
3: @ 0x2af470402ecf google::LogMessage::Flush()
3: @ 0x2af47040695d google::LogMessageFatal::~LogMessageFatal()
3: I1114 02:43:27.128705 18265 hierarchical.cpp:849] Updated allocation of framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000 on agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 from disk(allocated: *)[RAW]:200 to disk(allocated: *)[BLOCK]:200
3: I1114 02:43:27.129411 18265 hierarchical.cpp:1125] Recovered disk(allocated: *)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[BLOCK]:200, allocated: {}) on agent 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-S0 from framework 7b4e57ef-53f4-4165-9ddf-515e4bf492b9-0000
3: I1114 02:43:27.136329 18277 hierarchical.cpp:1450] Performed allocation for 1 agents in 2.074865ms
3: @ 0xaa32b7 _CheckFatal::~_CheckFatal()
3: @ 0x2af46d10e77b mesos::internal::master::Slave::apply()
3: @ 0x2af46d104014 mesos::internal::master::Master::updateOfferOperation()
3: @ 0x2af46d0b504d mesos::internal::master::Master::offerOperationStatusUpdate()
3: @ 0x2af46d225d74 ProtobufProcess<>::_handlerM<>()
3: @ 0x2af46d22685c _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3: @ 0x2af46d226753 _ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEEclIJSD_SF_EvEET0_DpOT_
3: @ 0x2af46d2264d7 std::_Function_handler<>::_M_invoke()
3: @ 0xcedb00 std::function<>::operator()()
3: @ 0x2af46d12b786 ProtobufProcess<>::visit()
3: @ 0x2af46d0c2ee5 mesos::internal::master::Master::_visit()
3: @ 0x2af46d0c2504 mesos::internal::master::Master::visit()
3: @ 0x2af46d0c30f7 mesos::internal::master::Master::visit()
3: @ 0x2af46d204e7e process::MessageEvent::visit()
3: @ 0xaead01 process::ProcessBase::serve()
3: @ 0x2af46f934772 process::ProcessManager::resume()
3: @ 0x2af46f944801 process::ProcessManager::init_threads()::$_9::operator()()
3: @ 0x2af46f944745 _ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvE3$_9vEE9_M_invokeIJEEEvSt12_Index_tupleIJXspT_EEE
3: @ 0x2af46f944715 std::_Bind_simple<>::operator()()
3: @ 0x2af46f9446ec std::thread::_Impl<>::_M_run()
3: @ 0x2af47435aa60 (unknown)
3: @ 0x2af47062f184 start_thread
3: @ 0x2af474bc6ffd (unknown)
3/3 Test #3: MesosTests .......................***Exception: Other447.08 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 491.50 sec
The following tests FAILED:
3 - MesosTests (OTHER_FAULT)
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-1510625286-21742
Untagged: mesos-1510625286-21742:latest
Deleted: sha256:94475164e6db0ba41356b3253f44b5c1a9accaf9af64e5de4bcc69ad0937da0e
Deleted: sha256:8ec1fb25cdf3fc20fb2afaa3ba75624dc04dc9c182fb458a20253b9f1c837758
Deleted: sha256:2084d7088b3a5f24b2836a1eb04bd6a1b89ef56e8032b9c62c365ec7c5b54f5d
Deleted: sha256:3e8fd5083fb214f6071b8ec9e3e90d349375407468d7420fe894d8ae3ef2a37b
Deleted: sha256:db3e5044e841c01670fd6e4676762de421a903b659cccebaf13ab217ac2836bd
Deleted: sha256:9e7653dbaccdcbd7cf1f66395507ed04aab9f981868674f7fd21e77e06ca2da0
Deleted: sha256:3e1b8a305b4e8371ebaa9fb107e34ef4a454def8a3080d4b8b30cb97e7b042c6
Deleted: sha256:704ca4ee8bf92d0d1e00d58bfd310b09c12aed311e12e4c4ab11d7a974a46dce
Deleted: sha256:ae7e517ee75acc9898f287d42e3ca6df8c800a90417f0f62145691aacc4a0467
Deleted: sha256:ccd419253019a069503bc24ef17e3c95d42ff8a66289b2063d4f76235b0b3baa
Deleted: sha256:dd421be905e49243fde07cd34e75ad7d498b7cdeb790e49d4fdff613790f95d9
Deleted: sha256:44d23664032f068c6d682e19a6cb494e3cc58d791e510032a33a4c7e1c13334d
Deleted: sha256:06a7d0b4eb4a4b781c7dfa30678cffd6e8caea70b4d14f4ef42e4a45db3acf88
Deleted: sha256:2f5bd498dfd2a06f4937e0e29788d9ee45a4fbe2b6d681110275fb8185f3f2da
Deleted: sha256:3d818051b169fa05893605918f5a96b8e5ea6bb2671431563f3c9b09acc02cc6
Deleted: sha256:5d3bf6909b16931d6f2547e298d834beb749e1e131e3ea0b6366d0f6d9a5b9d9
Deleted: sha256:50db1d6523214ceb26693e1412454bea2c21be7b780063c0ff0820b09ae6b4b2
Deleted: sha256:06451327fc525da98582199419a1f7f092034067994ee5ac95d2932fe38484b7
Deleted: sha256:5226d6cf206169c8e38a36ba1c454badc28338f1afc688def0665d5420cfdab5
Deleted: sha256:60f2c6c8504e5aed11c348860305961afde1977abe8ee02156e25109c8fab399
Deleted: sha256:15fb19763d0c56cc8f9f03cac269d4986745a4bd51a8caf2c0fa2bea747a3e89
Deleted: sha256:01211d00e505ae0956adbae0a85e4daee1957cd4ac27eef006c9f529dda3209d
Deleted: sha256:27f2885430f3543cf1b13e649504bc921622bc8322697bc3fd3a0ec2beac8072
Deleted: sha256:a300f726587bdeece29b565f866c4038139e817150822203aa4c548a5877df1b
Deleted: sha256:6e153d6b7ae9b83af3d61b2522cf57656a9029ac9bea1178f7fdd22e3437512b
Deleted: sha256:d801d70bbbf703d68978e7f325b31725112f9e7ddfa211b760c367740bc0513b
Deleted: sha256:3719e7fb62cfb854bdaff31ad729e615188a4951d25ab35e93b329a44593bdcf
Deleted: sha256:aa00d3b0f09d506906bae55b975e6756ba12f316f3c102e51831baa553ea9b35
Deleted: sha256:423754fe28afe97a1e491db581c67f25768e8364ea374cbf993eaf8c4bed1932
Deleted: sha256:822201a4452f477358d5801f829a60f3e47035ff9bb03ec3d5570d4c2120b18c
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1990@gmail.com
Not sending mail to unregistered user yujie.jay@gmail.com