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=centos%3A7,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.70 MB...]
3: I1114 01:38:48.570044 17485 state.cpp:64] Recovering state from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_AgentEndpoint_1_iEKMmV/meta'
3: I1114 01:38:48.570391 17485 status_update_manager.cpp:203] Recovering status
update manager
3: I1114 01:38:48.570631 17492 containerizer.cpp:662] Recovering containerizer
3: I1114 01:38:48.572309 17487 provisioner.cpp:416] Provisioner recovery
complete
3: I1114 01:38:48.572703 17498 slave.cpp:6432] Finished recovery
3: I1114 01:38:48.573457 17491 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:38:48.573463 17486 slave.cpp:1007] New master detected at
master@172.17.0.2:39766
3: I1114 01:38:48.573542 17486 slave.cpp:1042] Detecting new master
3: I1114 01:38:48.576339 17487 process.cpp:3925] Handling HTTP event for
process 'slave(747)' with path: '/slave(747)/api/v1/resource_provider'
3: I1114 01:38:48.578838 17491 http.cpp:1185] HTTP POST for
/slave(747)/api/v1/resource_provider from 172.17.0.2:58523
3: I1114 01:38:48.579342 17491 manager.cpp:381] Subscribing resource provider
{"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:38:48.586408 17482 slave.cpp:883] Agent terminating
3: I1114 01:38:48.593624 17482 master.cpp:1151] Master terminating
3: [ OK ] ContentType/ResourceProviderManagerHttpApiTest.AgentEndpoint/1
(57 ms)
3: [ RUN ]
ContentType/ResourceProviderManagerHttpApiTest.ConvertResources/0
3: I1114 01:38:48.601476 17482 cluster.cpp:162] Creating default 'local'
authorizer
3: I1114 01:38:48.604607 17495 master.cpp:448] Master
60004f0f-e4bb-483f-93e3-50d736d7f470 (1dcb78ba374a) started on 172.17.0.2:39766
3: I1114 01:38:48.604630 17495 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/eyfKbv/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/eyfKbv/master"
--zk_session_timeout="10secs"
3: I1114 01:38:48.604964 17495 master.cpp:499] Master only allowing
authenticated frameworks to register
3: I1114 01:38:48.604977 17495 master.cpp:505] Master only allowing
authenticated agents to register
3: I1114 01:38:48.604987 17495 master.cpp:511] Master only allowing
authenticated HTTP frameworks to register
3: I1114 01:38:48.604998 17495 credentials.hpp:37] Loading credentials for
authentication from '/tmp/eyfKbv/credentials'
3: I1114 01:38:48.605334 17495 master.cpp:555] Using default 'crammd5'
authenticator
3: I1114 01:38:48.605515 17495 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
3: I1114 01:38:48.605691 17495 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
3: I1114 01:38:48.605820 17495 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
3: I1114 01:38:48.605942 17495 master.cpp:634] Authorization enabled
3: I1114 01:38:48.606135 17489 whitelist_watcher.cpp:77] No whitelist given
3: I1114 01:38:48.606182 17490 hierarchical.cpp:171] Initialized hierarchical
allocator process
3: I1114 01:38:48.608683 17491 master.cpp:2213] Elected as the leading master!
3: I1114 01:38:48.608714 17491 master.cpp:1693] Recovering from registrar
3: I1114 01:38:48.608889 17494 registrar.cpp:347] Recovering registrar
3: I1114 01:38:48.609483 17494 registrar.cpp:391] Successfully fetched the
registry (0B) in 548096ns
3: I1114 01:38:48.609593 17494 registrar.cpp:495] Applied 1 operations in
30962ns; attempting to update the registry
3: I1114 01:38:48.610183 17492 registrar.cpp:552] Successfully updated the
registry in 527872ns
3: I1114 01:38:48.610335 17492 registrar.cpp:424] Successfully recovered
registrar
3: I1114 01:38:48.610787 17497 master.cpp:1806] Recovered 0 agents from the
registry (129B); allowing 10mins for agents to re-register
3: I1114 01:38:48.610888 17483 hierarchical.cpp:209] Skipping recovery of
hierarchical allocator: nothing to recover
3: W1114 01:38:48.616560 17482 process.cpp:3178] Attempted to spawn already
running process files@172.17.0.2:39766
3: I1114 01:38:48.617372 17482 containerizer.cpp:301] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
3: W1114 01:38:48.617799 17482 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
3: W1114 01:38:48.617898 17482 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
3: I1114 01:38:48.617928 17482 provisioner.cpp:255] Using default backend 'copy'
3: I1114 01:38:48.619511 17482 cluster.cpp:448] Creating default 'local'
authorizer
3: I1114 01:38:48.621320 17490 slave.cpp:262] Mesos agent started on
(748)@172.17.0.2:39766
3: I1114 01:38:48.621337 17490 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_cO6rBy/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_cO6rBy/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_cO6rBy/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_cO6rBy/executor_secret_key"
--executor_shutdown_grace_period="5secs"
--fetcher_cache_dir="/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_cO6rBy/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_cO6rBy/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_cO6rBy"
--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_IgwAT1"
--zk_session_timeout="10secs"
3: I1114 01:38:48.621760 17490 credentials.hpp:86] Loading credential for
authentication from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_cO6rBy/credential'
3: I1114 01:38:48.621909 17490 slave.cpp:295] Agent using credential for:
test-principal
3: I1114 01:38:48.621928 17490 credentials.hpp:37] Loading credentials for
authentication from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_cO6rBy/http_credentials'
3: I1114 01:38:48.622200 17490 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1114 01:38:48.622305 17490 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-executor'
3: I1114 01:38:48.622488 17490 http.cpp:1045] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1114 01:38:48.622578 17490 http.cpp:1066] Creating default 'jwt' HTTP
authenticator for realm 'mesos-agent-readonly'
3: I1114 01:38:48.623941 17490 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:48.624143 17490 slave.cpp:601] Agent attributes: [ ]
3: I1114 01:38:48.624152 17490 slave.cpp:610] Agent hostname: 1dcb78ba374a
3: I1114 01:38:48.624352 17484 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:38:48.626070 17485 state.cpp:64] Recovering state from
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IgwAT1/meta'
3: I1114 01:38:48.626351 17485 status_update_manager.cpp:203] Recovering status
update manager
3: I1114 01:38:48.626574 17487 containerizer.cpp:662] Recovering containerizer
3: I1114 01:38:48.628119 17497 provisioner.cpp:416] Provisioner recovery
complete
3: I1114 01:38:48.628572 17495 slave.cpp:6432] Finished recovery
3: I1114 01:38:48.629470 17493 slave.cpp:1007] New master detected at
master@172.17.0.2:39766
3: I1114 01:38:48.629477 17486 status_update_manager.cpp:177] Pausing sending
status updates
3: I1114 01:38:48.629562 17493 slave.cpp:1042] Detecting new master
3: I1114 01:38:48.637856 17487 slave.cpp:1069] Authenticating with master
master@172.17.0.2:39766
3: I1114 01:38:48.637950 17487 slave.cpp:1078] Using default CRAM-MD5
authenticatee
3: I1114 01:38:48.638273 17498 authenticatee.cpp:121] Creating new client SASL
connection
3: I1114 01:38:48.638607 17483 master.cpp:8285] Authenticating
slave(748)@172.17.0.2:39766
3: I1114 01:38:48.638754 17490 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(1378)@172.17.0.2:39766
3: I1114 01:38:48.639066 17484 authenticator.cpp:98] Creating new server SASL
connection
3: I1114 01:38:48.639365 17488 authenticatee.cpp:213] Received SASL
authentication mechanisms: CRAM-MD5
3: I1114 01:38:48.639400 17488 authenticatee.cpp:239] Attempting to
authenticate with mechanism 'CRAM-MD5'
3: I1114 01:38:48.639549 17492 authenticator.cpp:204] Received SASL
authentication start
3: I1114 01:38:48.639611 17492 authenticator.cpp:326] Authentication requires
more steps
3: I1114 01:38:48.639744 17497 authenticatee.cpp:259] Received SASL
authentication step
3: I1114 01:38:48.639876 17497 authenticator.cpp:232] Received SASL
authentication step
3: I1114 01:38:48.639938 17497 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '1dcb78ba374a' server FQDN: '1dcb78ba374a'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
3: I1114 01:38:48.639952 17497 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
3: I1114 01:38:48.639994 17497 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
3: I1114 01:38:48.640018 17497 auxprop.cpp:109] Request to lookup properties
for user: 'test-principal' realm: '1dcb78ba374a' server FQDN: '1dcb78ba374a'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
3: I1114 01:38:48.640028 17497 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:38:48.640038 17497 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
3: I1114 01:38:48.640053 17497 authenticator.cpp:318] Authentication success
3: I1114 01:38:48.640149 17491 authenticatee.cpp:299] Authentication success
3: I1114 01:38:48.640281 17485 master.cpp:8315] Successfully authenticated
principal 'test-principal' at slave(748)@172.17.0.2:39766
3: I1114 01:38:48.640352 17489 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(1378)@172.17.0.2:39766
3: I1114 01:38:48.640523 17491 slave.cpp:1161] Successfully authenticated with
master master@172.17.0.2:39766
3: I1114 01:38:48.640774 17491 slave.cpp:1682] Will retry registration in
17135ns if necessary
3: I1114 01:38:48.641057 17498 master.cpp:6032] Received register agent message
from slave(748)@172.17.0.2:39766 (1dcb78ba374a)
3: I1114 01:38:48.641206 17483 slave.cpp:1682] Will retry registration in
28.532944ms if necessary
3: I1114 01:38:48.641225 17498 master.cpp:3870] Authorizing agent with
principal 'test-principal'
3: I1114 01:38:48.641608 17498 master.cpp:6026] Ignoring register agent message
from slave(748)@172.17.0.2:39766 (1dcb78ba374a) as registration is already in
progress
3: I1114 01:38:48.641676 17498 master.cpp:6092] Authorized registration of
agent at slave(748)@172.17.0.2:39766 (1dcb78ba374a)
3: I1114 01:38:48.641793 17498 master.cpp:6185] Registering agent at
slave(748)@172.17.0.2:39766 (1dcb78ba374a) with id
60004f0f-e4bb-483f-93e3-50d736d7f470-S0
3: I1114 01:38:48.642246 17484 registrar.cpp:495] Applied 1 operations in
68121ns; attempting to update the registry
3: I1114 01:38:48.642828 17484 registrar.cpp:552] Successfully updated the
registry in 520960ns
3: I1114 01:38:48.643115 17484 master.cpp:6232] Admitted agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a)
3: I1114 01:38:48.644060 17486 slave.cpp:1207] Registered with master
master@172.17.0.2:39766; given agent ID 60004f0f-e4bb-483f-93e3-50d736d7f470-S0
3: I1114 01:38:48.643821 17484 master.cpp:6263] Registered agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a) 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:48.644213 17487 status_update_manager.cpp:184] Resuming sending
status updates
3: I1114 01:38:48.644364 17493 hierarchical.cpp:593] Added agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 (1dcb78ba374a) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (allocated: {})
3: I1114 01:38:48.644408 17486 slave.cpp:1227] Checkpointing SlaveInfo to
'/tmp/ContentType_ResourceProviderManagerHttpApiTest_ConvertResources_0_IgwAT1/meta/slaves/60004f0f-e4bb-483f-93e3-50d736d7f470-S0/slave.info'
3: I1114 01:38:48.644745 17493 hierarchical.cpp:1450] Performed allocation for
1 agents in 191843ns
3: I1114 01:38:48.644915 17486 slave.cpp:1285] Forwarding total resources
cpus:2; mem:1024; disk:1024; ports:[31000-32000]
3: I1114 01:38:48.644991 17486 slave.cpp:1295] Forwarding total oversubscribed
resources {}
3: I1114 01:38:48.645704 17486 master.cpp:7051] Received update of agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]
3: I1114 01:38:48.645777 17486 master.cpp:7064] Received update of agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a) with total oversubscribed resources {}
3: I1114 01:38:48.645990 17486 master.cpp:7082] Ignoring update on agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a) as it reports no changes
3: I1114 01:38:48.646215 17488 http_connection.hpp:221] New endpoint detected
at http://172.17.0.2:39766/slave(748)/api/v1/resource_provider
3: I1114 01:38:48.648658 17487 http_connection.hpp:277] Connected with the
remote endpoint at http://172.17.0.2:39766/slave(748)/api/v1/resource_provider
3: I1114 01:38:48.649652 17497 http_connection.hpp:129] Sending 1 call to
http://172.17.0.2:39766/slave(748)/api/v1/resource_provider
3: I1114 01:38:48.651173 17484 process.cpp:3925] Handling HTTP event for
process 'slave(748)' with path: '/slave(748)/api/v1/resource_provider'
3: I1114 01:38:48.652519 17486 http.cpp:1185] HTTP POST for
/slave(748)/api/v1/resource_provider from 172.17.0.2:58525
3: I1114 01:38:48.652940 17498 manager.cpp:381] Subscribing resource provider
{"name":"test","type":"org.apache.mesos.rp.test"}
3: I1114 01:38:48.656337 17494 http_connection.hpp:129] Sending 3 call to
http://172.17.0.2:39766/slave(748)/api/v1/resource_provider
3: I1114 01:38:48.657797 17491 process.cpp:3925] Handling HTTP event for
process 'slave(748)' with path: '/slave(748)/api/v1/resource_provider'
3: I1114 01:38:48.659085 17487 http.cpp:1185] HTTP POST for
/slave(748)/api/v1/resource_provider from 172.17.0.2:58524
3: I1114 01:38:48.659600 17497 slave.cpp:6719] Handling resource provider
message 'UPDATE_TOTAL_RESOURCES: 823a0f05-c5af-4ac7-905c-5df9d080ff33
disk[RAW]:200'
3: I1114 01:38:48.659732 17497 slave.cpp:6764] Forwarding new total resources
cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:38:48.660713 17490 master.cpp:7051] Received update of agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a) with total resources cpus:2; mem:1024; disk:1024;
ports:[31000-32000]; disk[RAW]:200
3: I1114 01:38:48.662179 17482 scheduler.cpp:190] Version: 1.5.0
3: I1114 01:38:48.662302 17494 hierarchical.cpp:660] Agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 (1dcb78ba374a) updated with total
resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk[RAW]:200
3: I1114 01:38:48.662502 17493 scheduler.cpp:313] Using default 'basic' HTTP
authenticatee
3: I1114 01:38:48.662657 17494 hierarchical.cpp:1450] Performed allocation for
1 agents in 166809ns
3: I1114 01:38:48.662925 17490 scheduler.cpp:496] New master detected at
master@172.17.0.2:39766
3: I1114 01:38:48.662948 17490 scheduler.cpp:505] Waiting for 0ns before
initiating a re-(connection) attempt with the master
3: I1114 01:38:48.664719 17496 scheduler.cpp:387] Connected with the master at
http://172.17.0.2:39766/master/api/v1/scheduler
3: I1114 01:38:48.666016 17490 scheduler.cpp:249] Sending SUBSCRIBE call to
http://172.17.0.2:39766/master/api/v1/scheduler
3: I1114 01:38:48.667277 17486 process.cpp:3925] Handling HTTP event for
process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:38:48.668997 17494 http.cpp:1185] HTTP POST for
/master/api/v1/scheduler from 172.17.0.2:58527
3: I1114 01:38:48.669263 17494 master.cpp:2613] Received subscription request
for HTTP framework 'default'
3: I1114 01:38:48.669379 17494 master.cpp:2278] Authorizing framework principal
'test-principal' to receive offers for roles '{ * }'
3: I1114 01:38:48.669945 17495 master.cpp:2748] Subscribing framework 'default'
with checkpointing disabled and capabilities [ RESERVATION_REFINEMENT ]
3: I1114 01:38:48.670917 17487 hierarchical.cpp:303] Added framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000
3: I1114 01:38:48.671643 17494 scheduler.cpp:741] Enqueuing event SUBSCRIBED
received from http://172.17.0.2:39766/master/api/v1/scheduler
3: I1114 01:38:48.672188 17494 scheduler.cpp:741] Enqueuing event HEARTBEAT
received from http://172.17.0.2:39766/master/api/v1/scheduler
3: I1114 01:38:48.673002 17487 hierarchical.cpp:1450] Performed allocation for
1 agents in 1.923229ms
3: I1114 01:38:48.673889 17484 master.cpp:8115] Sending 1 offers to framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000 (default)
3: I1114 01:38:48.676215 17498 scheduler.cpp:741] Enqueuing event OFFERS
received from http://172.17.0.2:39766/master/api/v1/scheduler
3: I1114 01:38:48.678086 17493 scheduler.cpp:249] Sending ACCEPT call to
http://172.17.0.2:39766/master/api/v1/scheduler
3: I1114 01:38:48.680239 17497 process.cpp:3925] Handling HTTP event for
process 'master' with path: '/master/api/v1/scheduler'
3: I1114 01:38:48.681577 17496 http.cpp:1185] HTTP POST for
/master/api/v1/scheduler from 172.17.0.2:58526
3: I1114 01:38:48.682904 17496 master.cpp:10017] Removing offer
60004f0f-e4bb-483f-93e3-50d736d7f470-O0
3: I1114 01:38:48.683048 17496 master.cpp:4228] Processing ACCEPT call for
offers: [ 60004f0f-e4bb-483f-93e3-50d736d7f470-O0 ] on agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a) for framework 60004f0f-e4bb-483f-93e3-50d736d7f470-0000 (default)
3: I1114 01:38:48.684165 17496 master.cpp:5293] Processing CREATE_BLOCK
operation with source disk(allocated: *)[RAW]:200 from framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000 (default) to agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at slave(748)@172.17.0.2:39766
(1dcb78ba374a)
3: I1114 01:38:48.684864 17496 master.cpp:9900] Sending offer operation
$-!)4J1¸ßÙMV to agent 60004f0f-e4bb-483f-93e3-50d736d7f470-S0 at
slave(748)@172.17.0.2:39766 (1dcb78ba374a)
3: I1114 01:38:48.686460 17493 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
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 from framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000
3: I1114 01:38:48.686549 17493 hierarchical.cpp:1171] Framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000 filtered agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 for 5secs
3: I1114 01:38:48.688426 17485 http_connection.hpp:129] Sending 2 call to
http://172.17.0.2:39766/slave(748)/api/v1/resource_provider
3: I1114 01:38:48.689930 17496 process.cpp:3925] Handling HTTP event for
process 'slave(748)' with path: '/slave(748)/api/v1/resource_provider'
3: I1114 01:38:48.729338 17486 http.cpp:1185] HTTP POST for
/slave(748)/api/v1/resource_provider from 172.17.0.2:58524
3: I1114 01:38:48.730190 17491 slave.cpp:6719] Handling resource provider
message 'UPDATE_OFFER_OPERATION_STATUS:
{"framework_id":{"value":"60004f0f-e4bb-483f-93e3-50d736d7f470-0000"},"status":{"state":"OFFER_OPERATION_FINISHED","converted_resources":[{"provider_id":{"value":"823a0f05-c5af-4ac7-905c-5df9d080ff33"},"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":"823a0f05-c5af-4ac7-905c-5df9d080ff33"},"name":"disk","type":"SCALAR","scalar":{"value":200.0},"allocation_info":{"role":"*"},"disk":{"source":{"type":"BLOCK"}}}]},"operation_uuid":"JC0hlSk0SjG4gN\/ZTVYdgw=="}'
3: I1114 01:38:48.730583 17491 slave.cpp:6893] Updating the state of offer
operation '' (uuid: $-!)4J1¸ßÙMV ) of framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000 (latest state:
OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: I1114 01:38:48.730984 17491 slave.cpp:6817] Forwarding status update of
offer operation '' (uuid: 242d2195-2934-4a31-b880-dfd94d561d83) for framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000
3: I1114 01:38:48.731549 17488 master.cpp:9698] Updating the state of offer
operation '' (uuid: 242d2195-2934-4a31-b880-dfd94d561d83) of framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000 (latest state:
OFFER_OPERATION_FINISHED, status update state: OFFER_OPERATION_FINISHED)
3: F1114 01:38:48.732025 17488 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: @ 0x7fd41d9ed84d google::LogMessage::Fail()
3: I1114 01:38:48.734227 17485 hierarchical.cpp:849] Updated allocation of
framework 60004f0f-e4bb-483f-93e3-50d736d7f470-0000 on agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 from disk(allocated: *)[RAW]:200 to
disk(allocated: *)[BLOCK]:200
3: @ 0x7fd41d9ef61c google::LogMessage::SendToLog()
3: I1114 01:38:48.734838 17485 hierarchical.cpp:1125] Recovered disk(allocated:
*)[BLOCK]:200 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000];
disk[BLOCK]:200, allocated: {}) on agent
60004f0f-e4bb-483f-93e3-50d736d7f470-S0 from framework
60004f0f-e4bb-483f-93e3-50d736d7f470-0000
3: @ 0x7fd41d9ed43c google::LogMessage::Flush()
3: @ 0x7fd41d9eff2e google::LogMessageFatal::~LogMessageFatal()
3: I1114 01:38:48.742316 17489 hierarchical.cpp:1450] Performed allocation for
1 agents in 1.713181ms
3: @ 0xc98901 _CheckFatal::~_CheckFatal()
3: @ 0x7fd4249c1e8b mesos::internal::master::Slave::apply()
3: @ 0x7fd4249b7736
mesos::internal::master::Master::updateOfferOperation()
3: @ 0x7fd4249a248d
mesos::internal::master::Master::offerOperationStatusUpdate()
3: @ 0x7fd424a0bf2c ProtobufProcess<>::_handlerM<>()
3: @ 0x7fd424ad0f68
_ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEE6__callIvJSD_SF_EJLm0ELm1ELm2ELm3EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
3: @ 0x7fd424aad4a3
_ZNSt5_BindIFPFvPN5mesos8internal6master6MasterEMS3_FvRKNS1_26OfferOperationStatusUpdateEERKN7process4UPIDERKSsES4_S9_St12_PlaceholderILi1EESI_ILi2EEEEclIJSD_SF_EvEET0_DpOT_
3: @ 0x7fd424a7eec2 std::_Function_handler<>::_M_invoke()
3: @ 0xea285d std::function<>::operator()()
3: @ 0x7fd4249eacda ProtobufProcess<>::visit()
3: @ 0x7fd424977743 mesos::internal::master::Master::_visit()
3: @ 0x7fd424976e22 mesos::internal::master::Master::visit()
3: @ 0x7fd4249ce6a8 process::MessageEvent::visit()
3: @ 0xcb40a4 process::ProcessBase::serve()
3: @ 0x7fd41eb81646 process::ProcessManager::resume()
3: @ 0x7fd41eb7da20
_ZZN7process14ProcessManager12init_threadsEvENKUlvE_clEv
3: @ 0x7fd41eb90d64
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
3: @ 0x7fd41eb90ca8
_ZNSt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEclEv
3: @ 0x7fd41eb90c32
_ZNSt6thread5_ImplISt12_Bind_simpleIFZN7process14ProcessManager12init_threadsEvEUlvE_vEEE6_M_runEv
3: @ 0x7fd419c412b0 (unknown)
3: @ 0x7fd41d7cde25 start_thread
3: @ 0x7fd4193a934d __clone
3/3 Test #3: MesosTests .......................***Exception: Other294.99 sec
67% tests passed, 1 tests failed out of 3
Total Test time (real) = 323.97 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-1510621575-30932
Untagged: mesos-1510621575-30932:latest
Deleted: sha256:c5e03ae6e0ebeb064b7275174162a229941843fec3bc3fcb543b770c66f671c1
Deleted: sha256:8df47a4e9d5901156d61a381f12d4cdb3f73d26a03fa13d6e4ce47478f7e8031
Deleted: sha256:bfe81e11f839cd0455a270781b55a3e92c10fdb219d289edd612b23e5efbbdea
Deleted: sha256:b361325522056034c2ef507618fafb2be4267a096cc565b7d4dc7539ceb8d1fb
Deleted: sha256:af89497a0b52f1145fdd65ee1eedf72386890e37b91e57343cdb180ba911c4d9
Deleted: sha256:f4b14664c9f8fb676b3fbf55ce4c675a3de727910550082dffa3182f6b785ae7
Deleted: sha256:a123177bc21b4b8f9e68327949edced2b2412b54a42d5152d2efcd53b773e741
Deleted: sha256:3c8d1298f81ccd0c880859ddbe7989e13c07cfc062454f4d6e826ff0704cbdcc
Deleted: sha256:959b0c5e9aec179ffeb151673e9caf06468b3842de79e5aa1894d280859721ab
Deleted: sha256:d70ecb807fdfcab4f707708dbf7a7a2fd89659764bed573f2544d05caef9bcae
Deleted: sha256:705bb1b28238b85ea21aadc1081e270b4e1b49c18d12a26eccaf04eb8bd811af
Deleted: sha256:9e5824d2c3b183ad4cb6853fd6ee2bd80aaa8f3d89a9b763ea001ca11c935cca
Deleted: sha256:5ec3b74fdbb853fa25de5208ae179bd2d1bb6e90684ede14f7b90c7a7a075ace
Deleted: sha256:1301f53823313a2aab225bff41ea6e2f258d20933c84f419c038fb811814565d
Deleted: sha256:b36254653b90f503c6efda2aa5744865fd2e0f890edd8c2f948bdfee7dae5d0e
Deleted: sha256:144875d85b5b12d266719dc811eb36c14a6dba1ad5224a1aa2197841a99ba970
Deleted: sha256:2d1e080ca2b22bf739c4ad662abd8ac7489bef1aab5dc85b2c854a1c0b604089
Deleted: sha256:b8ab58dcd9b1906b9cb1235cd0c0f49d4403f6a81861ed29ee411ef5b92335fd
Deleted: sha256:a5fbc20dcb3ff5fdd59345d2cb8eb50edeb85999d9a61c777b193f2a7d3b1e90
Deleted: sha256:53f892de0715f99c75e40a2c3bdc3da597aca1c6ccbdeb59cd4e9a722d674c60
Deleted: sha256:ab8e39ef942fe3a0e5e73c5ead2e0ff6333ddee3c3895c4356a3c2503fe684f9
Deleted: sha256:06e9ee475a3435324a25119f5ebdbf1fba698ab2529a63ef14bfbdb47dd8cd22
Deleted: sha256:c99bcaae74758389d51d013a51b46b4c485ab0e5d881901649bec0e7d40613aa
Deleted: sha256:6ecbb8c37750c34071b6460acf52b708535f252e369efee034e12b76fecded40
Deleted: sha256:2171e129194c12468129b5a12bbcae714a38f88029ab2821d3fa6173b3f15972
Deleted: sha256:53b4900b3640bf7f17693cafd1520f3c2a7de2a4f6a7dd0206859aae87cf4afa
Deleted: sha256:46f74b52a9a79a1898ddbdf4ddb25c632b8a56e81bcb841daa66d1be4e5beb3f
Deleted: sha256:fb3795d9c7bfb8f297140b9d85f781e0950cea34f2f94f900032f460bb6ef795
Deleted: sha256:c4777536a51766d3c0c4559bed8c82f5912121f6b6edc508af393007cfdfe04e
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
