See
<https://builds.apache.org/job/Mesos-Buildbot/BUILDTOOL=cmake,COMPILER=gcc,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.83 MB...]
3: I1114 01:44:29.187314 19962 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:44:29.189595 19956 state.cpp:64] Recovering state from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_IJQKYf/meta'
3: I1114 01:44:29.190078 19948 status_update_manager.cpp:203] Recovering status
update manager
3: I1114 01:44:29.190379 19942 containerizer.cpp:662] Recovering containerizer
3: I1114 01:44:29.191932 19965 provisioner.cpp:416] Provisioner recovery
complete
3: I1114 01:44:29.192266 19954 slave.cpp:6432] Finished recovery
3: I1114 01:44:29.192991 19963 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:44:29.193025 19950 slave.cpp:1007] New master detected at
master@172.17.0.9:41258
3: I1114 01:44:29.193114 19950 slave.cpp:1042] Detecting new master
3: I1114 01:44:29.195739 19944 process.cpp:3925] Handling HTTP event for
process 'slave(750)' with path: '/slave(750)/api/v1/resource_provider'
3: I1114 01:44:29.198395 19946 http.cpp:1185] HTTP POST for
/slave(750)/api/v1/resource_provider from 172.17.0.9:53008
3: I1114 01:44:29.198834 19962 manager.cpp:381] Subscribing resource provider
{"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:44:29.205705 19941 slave.cpp:883] Agent terminating
3: I1114 01:44:29.214551 19941 master.cpp:1151] Master terminating
3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1
(60 ms)
3: [ RUN ]
ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
3: I1114 01:44:29.223004 19941 cluster.cpp:162] Creating default 'local'
authorizer
3: I1114 01:44:29.227275 19965 master.cpp:448] Master
d2a0bf50-f25a-4a49-b17c-b8cbcd228032 (105641e656fc) started on 172.17.0.9:41258
3: I1114 01:44:29.227293 19965 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/RCChkC/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/RCChkC/master"
--zk_session_timeout="10secs"
3: I1114 01:44:29.227607 19965 master.cpp:499] Master only allowing
authenticated frameworks to register
3: I1114 01:44:29.227613 19965 master.cpp:505] Master only allowing
authenticated agents to register
3: I1114 01:44:29.227617 19965 master.cpp:511] Master only allowing
authenticated HTTP frameworks to register
3: I1114 01:44:29.227622 19965 credentials.hpp:37] Loading credentials for
authentication from '/tmp/RCChkC/credentials'
3: I1114 01:44:29.227864 19965 master.cpp:555] Using default 'crammd5'
authenticator
3: I1114 01:44:29.228010 19965 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
3: I1114 01:44:29.228133 19965 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
3: I1114 01:44:29.228265 19965 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
3: I1114 01:44:29.228373 19965 master.cpp:634] Authorization enabled
3: I1114 01:44:29.228565 19943 whitelist_watcher.cpp:77] No whitelist given
3: I1114 01:44:29.228605 19963 hierarchical.cpp:171] Initialized hierarchical
allocator process
3: I1114 01:44:29.231273 19950 master.cpp:2213] Elected as the leading master!
3: I1114 01:44:29.231303 19950 master.cpp:1693] Recovering from registrar
3: I1114 01:44:29.231457 19949 registrar.cpp:347] Recovering registrar
3: I1114 01:44:29.232230 19949 registrar.cpp:391] Successfully fetched the
registry (0B) in 709888ns
3: I1114 01:44:29.232395 19949 registrar.cpp:495] Applied 1 operations in
51447ns; attempting to update the registry
3: I1114 01:44:29.233088 19949 registrar.cpp:552] Successfully updated the
registry in 591104ns
3: I1114 01:44:29.233283 19949 registrar.cpp:424] Successfully recovered
registrar
3: I1114 01:44:29.233772 19959 master.cpp:1806] Recovered 0 agents from the
registry (129B); allowing 10mins for agents to re-register
3: I1114 01:44:29.233989 19956 hierarchical.cpp:209] Skipping recovery of
hierarchical allocator: nothing to recover
3: W1114 01:44:29.240334 19941 process.cpp:3178] Attempted to spawn already
running process files@172.17.0.9:41258
3: I1114 01:44:29.241632 19941 containerizer.cpp:301] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1114 01:44:29.242388 19941 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
3: W1114 01:44:29.242560 19941 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
3: I1114 01:44:29.242610 19941 provisioner.cpp:255] Using default backend 'copy'
3: I1114 01:44:29.245019 19941 cluster.cpp:448] Creating default 'local'
authorizer
3: I1114 01:44:29.247846 19943 slave.cpp:262] Mesos agent started on
(751)@172.17.0.9:41258
3: I1114 01:44:29.247886 19943 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_OgIcqR/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_OgIcqR/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_OgIcqR/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_OgIcqR/executor_secret_key"
--executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_OgIcqR/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_OgIcqR/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_OgIcqR"
--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_HxfeSJ"
--zk_session_timeout="10secs"
3: I1114 01:44:29.248690 19943 credentials.hpp:86] Loading credential for
authentication from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_OgIcqR/credential'
3: I1114 01:44:29.248968 19943 slave.cpp:295] Agent using credential for:
test-principal
3: I1114 01:44:29.249011 19943 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_OgIcqR/http_credentials'
3: I1114 01:44:29.249377 19943 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1114 01:44:29.249511 19943 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1114 01:44:29.249722 19943 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1114 01:44:29.249830 19943 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1114 01:44:29.251304 19943 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:44:29.251529 19943 slave.cpp:601] Agent attributes: [ ]
3: I1114 01:44:29.251543 19943 slave.cpp:610] Agent hostname: 105641e656fc
3: I1114 01:44:29.251667 19955 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:44:29.253199 19951 state.cpp:64] Recovering state from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_HxfeSJ/meta'
3: I1114 01:44:29.253604 19959 status_update_manager.cpp:203] Recovering status
update manager
3: I1114 01:44:29.253917 19954 containerizer.cpp:662] Recovering containerizer
3: I1114 01:44:29.255928 19946 provisioner.cpp:416] Provisioner recovery
complete
3: I1114 01:44:29.256384 19961 slave.cpp:6432] Finished recovery
3: I1114 01:44:29.257439 19943 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:44:29.257462 19957 slave.cpp:1007] New master detected at
master@172.17.0.9:41258
3: I1114 01:44:29.257535 19957 slave.cpp:1042] Detecting new master
3: I1114 01:44:29.265980 19951 slave.cpp:1069] Authenticating with master
master@172.17.0.9:41258
3: I1114 01:44:29.266113 19951 slave.cpp:1078] Using default CRAM-MD5
authenticatee
3: I1114 01:44:29.266520 19959 authenticatee.cpp:121] Creating new client SASL
connection
3: I1114 01:44:29.266959 19953 master.cpp:8285] Authenticating
slave(751)@172.17.0.9:41258
3: I1114 01:44:29.267091 19948 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(1385)@172.17.0.9:41258
3: I1114 01:44:29.267436 19963 authenticator.cpp:98] Creating new server SASL
connection
3: I1114 01:44:29.267835 19958 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1114 01:44:29.267877 19958 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1114 01:44:29.268076 19960 authenticator.cpp:204] Received SASL
authentication start
3: I1114 01:44:29.268167 19960 authenticator.cpp:326] Authentication requires
more steps
3: I1114 01:44:29.268296 19960 authenticatee.cpp:259] Received SASL
authentication step
3: I1114 01:44:29.268540 19965 authenticator.cpp:232] Received SASL
authentication step
3: I1114 01:44:29.268602 19965 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '105641e656fc' server FQDN: '105641e656fc'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1114 01:44:29.268636 19965 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1114 01:44:29.268667 19965 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1114 01:44:29.268712 19965 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '105641e656fc' server FQDN: '105641e656fc'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1114 01:44:29.268728 19965 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:44:29.268748 19965 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:44:29.268761 19965 authenticator.cpp:318] Authentication success
3: I1114 01:44:29.268929 19954 authenticatee.cpp:299] Authentication success
3: I1114 01:44:29.269009 19947 master.cpp:8315] Successfully authenticated
principal 'test-principal' at slave(751)@172.17.0.9:41258
3: I1114 01:44:29.269068 19945 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(1385)@172.17.0.9:41258
3: I1114 01:44:29.269248 19950 slave.cpp:1161] Successfully authenticated with
master master@172.17.0.9:41258
3: I1114 01:44:29.269469 19950 slave.cpp:1682] Will retry registration in
10.356269ms if necessary
3: I1114 01:44:29.269656 19961 master.cpp:6032] Received register agent message
from slave(751)@172.17.0.9:41258 (105641e656fc)
3: I1114 01:44:29.269773 19961 master.cpp:3870] Authorizing agent with
principal 'test-principal'
3: I1114 01:44:29.270182 19962 master.cpp:6092] Authorized registration of
agent at slave(751)@172.17.0.9:41258 (105641e656fc)
3: I1114 01:44:29.270295 19962 master.cpp:6185] Registering agent at
slave(751)@172.17.0.9:41258 (105641e656fc) with id
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0
3: I1114 01:44:29.270663 19943 registrar.cpp:495] Applied 1 operations in
52718ns; attempting to update the registry
3: I1114 01:44:29.271152 19943 registrar.cpp:552] Successfully updated the
registry in 439808ns
3: I1114 01:44:29.271349 19959 master.cpp:6232] Admitted agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc)
3: I1114 01:44:29.272315 19948 slave.cpp:1207] Registered with master
master@172.17.0.9:41258; given agent ID d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0
3: I1114 01:44:29.272114 19959 master.cpp:6263] Registered agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc) 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:44:29.272436 19944 status_update_manager.cpp:184] Resuming sending
status updates
3: I1114 01:44:29.272531 19963 hierarchical.cpp:593] Added agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 (105641e656fc) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
3: I1114 01:44:29.272626 19948 slave.cpp:1227] Checkpointing SlaveInfo to
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_HxfeSJ/meta/slaves/d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0/slave.info'
3: I1114 01:44:29.272837 19963 hierarchical.cpp:1450] Performed allocation for
1 agents in 141236ns
3: I1114 01:44:29.272992 19948 slave.cpp:1285] Forwarding total resources
cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 01:44:29.273087 19948 slave.cpp:1295] Forwarding total oversubscribed
resources {}
3: I1114 01:44:29.273730 19960 master.cpp:7051] Received update of agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]
3: I1114 01:44:29.273790 19960 master.cpp:7064] Received update of agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc) with total oversubscribed resources {}
3: I1114 01:44:29.273982 19960 master.cpp:7082] Ignoring update on agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc) as it reports no changes
3: I1114 01:44:29.274179 19960 http_connection.hpp:221] New endpoint detected
at http://172.17.0.9:41258/slave(751)/api/v1/resource_provider
3: I1114 01:44:29.276432 19956 http_connection.hpp:277] Connected with the
remote endpoint at http://172.17.0.9:41258/slave(751)/api/v1/resource_provider
3: I1114 01:44:29.277712 19948 http_connection.hpp:129] Sending 1 call to
http://172.17.0.9:41258/slave(751)/api/v1/resource_provider
3: I1114 01:44:29.279109 19946 process.cpp:3925] Handling HTTP event for
process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 01:44:29.280530 19949 http.cpp:1185] HTTP POST for
/slave(751)/api/v1/resource_provider from 172.17.0.9:53012
3: I1114 01:44:29.280936 19962 manager.cpp:381] Subscribing resource provider
{"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:44:29.284565 19960 http_connection.hpp:129] Sending 3 call to
http://172.17.0.9:41258/slave(751)/api/v1/resource_provider
3: I1114 01:44:29.286666 19943 process.cpp:3925] Handling HTTP event for
process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 01:44:29.287875 19963 http.cpp:1185] HTTP POST for
/slave(751)/api/v1/resource_provider from 172.17.0.9:53010
3: I1114 01:44:29.288434 19957 slave.cpp:6719] Handling resource provider
message 'UPDATE_TOTAL_RESOURCES: 36898533-7448-456c-85e8-8e08ddc296d7
disk[RAW]:200'
3: I1114 01:44:29.288671 19957 slave.cpp:6764] Forwarding new total resources
cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:44:29.289738 19948 master.cpp:7051] Received update of agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]; disk[RAW]:200
3: I1114 01:44:29.291210 19941 scheduler.cpp:190] Version: 1.5.0
3: I1114 01:44:29.291218 19942 hierarchical.cpp:660] Agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 (105641e656fc) updated with total
resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:44:29.291487 19960 scheduler.cpp:313] Using default 'basic' HTTP
authenticatee
3: I1114 01:44:29.291502 19942 hierarchical.cpp:1450] Performed allocation for
1 agents in 136110ns
3: I1114 01:44:29.292016 19959 scheduler.cpp:496] New master detected at
master@172.17.0.9:41258
3: I1114 01:44:29.292122 19959 scheduler.cpp:505] Waiting for 0ns before
initiating a re-(connection) attempt with the master
3: I1114 01:44:29.293927 19956 scheduler.cpp:387] Connected with the master at
http://172.17.0.9:41258/master/api/v1/scheduler
3: I1114 01:44:29.295339 19949 scheduler.cpp:249] Sending SUBSCRIBE call to
http://172.17.0.9:41258/master/api/v1/scheduler
3: I1114 01:44:29.297857 19959 process.cpp:3925] Handling HTTP event for
process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:44:29.299445 19955 http.cpp:1185] HTTP POST for
/master/api/v1/scheduler from 172.17.0.9:53016
3: I1114 01:44:29.299685 19955 master.cpp:2613] Received subscription request
for HTTP framework 'default'
3: I1114 01:44:29.299800 19955 master.cpp:2278] Authorizing framework principal
'test-principal' to receive offers for roles '{ * }'
3: I1114 01:44:29.300338 19947 master.cpp:2748] Subscribing framework 'default'
with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1114 01:44:29.301280 19954 hierarchical.cpp:303] Added framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000
3: I1114 01:44:29.301973 19953 scheduler.cpp:741] Enqueuing event SUBSCRIBED
received from http://172.17.0.9:41258/master/api/v1/scheduler
3: I1114 01:44:29.302489 19953 scheduler.cpp:741] Enqueuing event HEARTBEAT
received from http://172.17.0.9:41258/master/api/v1/scheduler
3: I1114 01:44:29.302845 19954 hierarchical.cpp:1450] Performed allocation for
1 agents in 1.42472ms
3: I1114 01:44:29.303576 19952 master.cpp:8115] Sending 1 offers to framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 (default)
3: I1114 01:44:29.306180 19960 scheduler.cpp:741] Enqueuing event OFFERS
received from http://172.17.0.9:41258/master/api/v1/scheduler
3: I1114 01:44:29.308259 19965 scheduler.cpp:249] Sending ACCEPT call to
http://172.17.0.9:41258/master/api/v1/scheduler
3: I1114 01:44:29.309893 19942 process.cpp:3925] Handling HTTP event for
process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:44:29.311262 19945 http.cpp:1185] HTTP POST for
/master/api/v1/scheduler from 172.17.0.9:53014
3: I1114 01:44:29.313117 19945 master.cpp:10017] Removing offer
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-O0
3: I1114 01:44:29.313302 19945 master.cpp:4228] Processing ACCEPT call for
offers: [ d2a0bf50-f25a-4a49-b17c-b8cbcd228032-O0 ] on agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc) for framework d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 (default)
3: I1114 01:44:29.314383 19945 master.cpp:5293] Processing CREATE_BLOCK
operation with source disk(allocated: *)[RAW]:200 from framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 (default) to agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at slave(751)@172.17.0.9:41258
(105641e656fc)
3: I1114 01:44:29.315264 19945 master.cpp:9900] Sending offer operation
AO´äAú½bæ£rA to agent d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 at
slave(751)@172.17.0.9:41258 (105641e656fc)
3: I1114 01:44:29.316747 19943 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
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 from framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000
3: I1114 01:44:29.316819 19943 hierarchical.cpp:1171] Framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 filtered agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 for 5secs
3: I1114 01:44:29.319196 19956 http_connection.hpp:129] Sending 2 call to
http://172.17.0.9:41258/slave(751)/api/v1/resource_provider
3: I1114 01:44:29.320287 19947 process.cpp:3925] Handling HTTP event for
process 'slave(751)' with path: '/slave(751)/api/v1/resource_provider'
3: I1114 01:44:29.358463 19945 http.cpp:1185] HTTP POST for
/slave(751)/api/v1/resource_provider from 172.17.0.9:53010
3: I1114 01:44:29.359478 19964 slave.cpp:6719] Handling resource provider
message 'UPDATE_OFFER_OPERATION_STATUS:
{"framework_id":{"value":"d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000"},"status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"36898533-7448-456c-85e8-8e08ddc296d7"},"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":"36898533-7448-456c-85e8-8e08ddc296d7"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"operation_uuid":"QRtPBLTkQfqTvWLmo3JBFw=="}'
3: I1114 01:44:29.359866 19964 slave.cpp:6893] Updating the state of offer
operation '' (uuid: AO´äAú½bæ£rA) of framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 (latest state:
OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1114 01:44:29.360292 19964 slave.cpp:6817] Forwarding status update of
offer operation '' (uuid: 411b4f04-b4e4-41fa-93bd-62e6a3724117) for framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000
3: I1114 01:44:29.360893 19957 master.cpp:9698] Updating the state of offer
operation '' (uuid: 411b4f04-b4e4-41fa-93bd-62e6a3724117) of framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 (latest state:
OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: F1114 01:44:29.361497 19957 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: @ 0x2b783de3e9fd google::LogMessage::Fail()
3: @ 0x2b783de4089d google::LogMessage::SendToLog()
3: @ 0x2b783de3e5ec google::LogMessage::Flush()
3: @ 0x2b783de411be google::LogMessageFatal::~LogMessageFatal()
3: I1114 01:44:29.363132 19965 hierarchical.cpp:849] Updated allocation of
framework d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000 on agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 from disk(allocated: *)[RAW]:200 to
disk(allocated: *)[BLOCK]:200
3: I1114 01:44:29.363553 19965 hierarchical.cpp:1125] Recovered disk(allocated:
*)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000];
disk[BLOCK]:200, allocated: {}) on agent
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-S0 from framework
d2a0bf50-f25a-4a49-b17c-b8cbcd228032-0000
3: @ 0xc98678 _CheckFatal::~_CheckFatal()
3: I1114 01:44:29.372593 19944 hierarchical.cpp:1450] Performed allocation for
1 agents in 1.396364ms
3: @ 0x2b783b1a33d1 mesos::internal::master::Slave::apply()
3: @ 0x2b783b199394
mesos::internal::master::Master::updateOfferOperation()
3: @ 0x2b783b1843a7
mesos::internal::master::Master::offerOperationStatusUpdate()
3: @ 0x2b783b1e8b45 ProtobufProcess<>::_handlerM<>()
3: @ 0x2b783b2a2b0f
_ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3: @ 0x2b783b280d46
_ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEEclIJSD_SF_EvEET0_DpOT_
3: @ 0x2b783b255c82 std::_Function_handler<>::_M_invoke()
3: @ 0xe84ae3 std::function<>::operator()()
3: @ 0x2b783b1ca11c ProtobufProcess<>::visit()
3: @ 0x2b783b15a1c0 mesos::internal::master::Master::_visit()
3: @ 0x2b783b1598d2 mesos::internal::master::Master::visit()
3: @ 0x2b783b1aef68 process::MessageEvent::visit()
3: @ 0xcb24d2 process::ProcessBase::serve()
3: @ 0x2b783d885c7d process::ProcessManager::resume()
3: @ 0x2b783d8820dc
_ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
3: @ 0x2b783d894404
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
3: @ 0x2b783d89435b
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
3: @ 0x2b783d8942f4
_ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
3: @ 0x2b7840874a60 (unknown)
3: @ 0x2b783e06a184 start_thread
3: @ 0x2b78410e0ffd (unknown)
3/3 Test #3: MesosTests .......................***Exception: Other325.28 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 366.22 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-1510621681-1530
Untagged: mesos-1510621681-1530:latest
Deleted: sha256:e46622552a4c320f34727e4670c1e2996031d019d6565cb04c7101b5765f2bba
Deleted: sha256:5a522119017b515c5b0487d95b53ab2a20f96a293ddbd6182cb2f26968bf4b38
Deleted: sha256:85cc93a70ee8dc051cb2afff55904f077cdc6453f702050a89fdd9ef90d41df4
Deleted: sha256:59d061dc190dc0226b74a4cbe1f7227177f358e34fe07c9dfbcaf2d547525418
Deleted: sha256:6fd6d33b015dabf7aa6951060b372bd3811022ff10966ef3f36bab840d73aa72
Deleted: sha256:b07715b497da147f122fcffd2418688b8e9a13a5b091863d87e4684c2971a55a
Deleted: sha256:391ed38bb3299ecbaf4882c3abd5489199dbf57b89d91e2f1700c5bebdd509a1
Deleted: sha256:58211cad13c985e062c8dfd0b1be345aa4f76ff486059e2b318f5cdb56db39ed
Deleted: sha256:a99242f470a25bbc8b4599001180dfb6705273571106e31aa524553dbe08893d
Deleted: sha256:bacddc90fa1996b8b74865b77d1c9aa6db18fbcf3a655f0e1e744ba37ed2077b
Deleted: sha256:de7e09ba9357571b22a0fc7eb106fa52876e998283bc710ca0b6a86509cb6612
Deleted: sha256:b33545830d8ea731c7a3e222ec4432965eaa73a70d39a170db8abfb892a0af95
Deleted: sha256:865a053b3caa897dbbe3ca394d8b4068674c8836d6074bb93df1e29bfbcd595a
Deleted: sha256:a2d5ef98dbdcbcbbf1d6ea24132931c5956e1a3d18dc4c691516ebe6ea114959
Deleted: sha256:579b7c97f0b66084c113a7355c4d2a75000111aedbb23ea7d0e0319c0fc5cee2
Deleted: sha256:fe9b3135fab8c787564f1f269ffb8848850b266baf5cb1f1e0b467a346de339b
Deleted: sha256:ed5a46335bc2c9f48358bd7fe8dae0eeaf6d123f89537fcd74bcd56014897884
Deleted: sha256:6540cc66a7764b0aac5fe5c81a2a7c9297624e21a969356622cc47645eb23311
Deleted: sha256:5c04b9e491f4ecedc48ccc8a16fc104c9a96fd072bd0a21e99beba72bb16dcba
Deleted: sha256:7ba59fd62106d5a02509ac56160a08f18b8c0e8610d9054bf21c05cf132255c9
Deleted: sha256:d7684a119d9b3d316adb2e4ac7afca20b781b96becf89df9ee5d15acc5dd8c29
Deleted: sha256:87810b397b67785e4f881b434d5ce0424d81a63bf19194ef2d832ab1b336602c
Deleted: sha256:bf276be643fd182f8e0d4bebb41028c4a776b0aff12399bb400ff5e77d2ee541
Deleted: sha256:34e78a32b74d094ce0dacff377082eb7322f4d4cc4d0bbdc3e1ac9fdc3667e56
Deleted: sha256:f384025145cb114181ea904996419556eebce8377e1219b238425b12cae3aaaa
Deleted: sha256:c5b5083bc1d4570ecef82453cd636685e76313301029dd2361829369c519d7a8
Deleted: sha256:44afcb09a799c16be6ee8da26e77ebccdfb10c75a41e86efefa8f54c19f0daa4
Deleted: sha256:5f532cb55eef43cb15c31cac08ee2bdcad5e110bf4c7f23386f9ecde52293b74
Deleted: sha256:928503fabaf5723f2de953e2685d4027cd97858012e6bbe8b09a53ac2938355e
Deleted: sha256:614ac9b4938297b33caa7ae01ef4da4e97ab47ef72d575c415abdc86ea0481f4
Build step 'Execute shell' marked build as failure
Not sending mail to unregistered user songzihao1...@gmail.com
Not sending mail to unregistered user yujie....@gmail.com
