Re: Review Request 71302: Marked /quota endpoint as deprecated.

Mesos Reviewbot Fri, 16 Aug 2019 19:23:54 -0700

-----------------------------------------------------------
This is an automatically generated e-mail. To reply, visit:
https://reviews.apache.org/r/71302/#review217255
-----------------------------------------------------------




Bad patch!

Reviews applied: [71302]

Failed command: ['bash', '-c', "set -o pipefail; export OS='ubuntu:14.04' 
BUILDTOOL='autotools' COMPILER='gcc' CONFIGURATION='--verbose 
--disable-libtool-wrappers --disable-parallel-test-execution' 
ENVIRONMENT='GLOG_v=1 MESOS_VERBOSE=1'; ./support/docker-build.sh 2>&1 | tee 
build_71302"]

Error:
...<truncated>...
red disk(allocated: storage/default-role)(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf,test),34b4d8b9-6cff-4741-89a3-40e1dc6b7f00:volume]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf,test),34b4d8b9-6cff-4741-89a3-40e1dc6b7f00:volume]:2048,
 allocated: {}) on agent 0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 
 from framework 0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000
I0817 02:23:24.089661 18756 hierarchical.cpp:1268] Framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 filtered agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 for 5secs
I0817 02:23:24.093324 18759 master.cpp:12615] Sending operation '' (uuid: 
aa128e0b-7efb-4ae7-a759-b21d4ea40ee5) to agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 at slave(1224)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.093925 18760 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:24.097290 18749 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:24.097327 18749 provider.cpp:1295] Received DESTROY operation '' 
(uuid: aa128e0b-7efb-4ae7-a759-b21d4ea40ee5)
I0817 02:23:24.101243 18759 http.cpp:1115] HTTP POST for 
/slave(1224)/api/v1/resource_provider from 172.17.0.2:33404
I0817 02:23:24.102300 18757 slave.cpp:8423] Handling resource provider message 
'UPDATE_OPERATION_STATUS: (uuid: 7c98d58c-8a3f-427c-94b6-0170fc950978) for 
framework  (latest state: OPERATION_FINISHED, status update state: 
OPERATION_FINISHED)'
I0817 02:23:24.102572 18757 slave.cpp:8876] Updating the state of operation 
with no ID (uuid: 7c98d58c-8a3f-427c-94b6-0170fc950978) for an operation API 
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0817 02:23:24.102648 18757 slave.cpp:8630] Forwarding status update of 
operation with no ID (operation_uuid: 7c98d58c-8a3f-427c-94b6-0170fc950978) for 
an operator API call
I0817 02:23:24.103116 18752 master.cpp:12271] Updating the state of operation 
'' (uuid: 7c98d58c-8a3f-427c-94b6-0170fc950978) for an operator API call 
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0817 02:23:24.103746 18753 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:24.103826 18760 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.443724ms
I0817 02:23:24.104676 18748 master.cpp:10432] Sending offers [ 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-O5 ] to framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053
I0817 02:23:24.105330 18759 sched.cpp:934] Scheduler::resourceOffers took 
79462ns
I0817 02:23:24.108573 18752 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
34b90631-d8ee-400e-bf33-28ba6833aeea) for operation UUID 
aa128e0b-7efb-4ae7-a759-b21d4ea40ee5 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.108635 18752 status_update_manager_process.hpp:414] Creating 
operation status update stream aa128e0b-7efb-4ae7-a759-b21d4ea40ee5 
checkpoint=true
I0817 02:23:24.108711 18749 provider.cpp:481] Received 
ACKNOWLEDGE_OPERATION_STATUS event
I0817 02:23:24.108919 18752 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: 34b90631-d8ee-400e-bf33-28ba6833aeea) for operation UUID 
aa128e0b-7efb-4ae7-a759-b21d4ea40ee5 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.125324 18752 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
34b90631-d8ee-400e-bf33-28ba6833aeea) for operation UUID 
aa128e0b-7efb-4ae7-a759-b21d4ea40ee5 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.125614 18752 status_update_manager_process.hpp:252] Received 
operation status update acknowledgement (UUID: 
154c4a3b-732d-427c-948a-be741d3561f1) for stream 
7c98d58c-8a3f-427c-94b6-0170fc950978
I0817 02:23:24.125685 18752 status_update_manager_process.hpp:929] 
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 
154c4a3b-732d-427c-948a-be741d3561f1) for operation UUID 
7c98d58c-8a3f-427c-94b6-0170fc950978 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.126077 18754 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1224)/api/v1/resource_provider
I0817 02:23:24.126971 18756 process.cpp:3671] Handling HTTP event for process 
'slave(1224)' with path: '/slave(1224)/api/v1/resource_provider'
I0817 02:23:24.142305 18752 status_update_manager_process.hpp:490] Cleaning up 
operation status update stream 7c98d58c-8a3f-427c-94b6-0170fc950978
I0817 02:23:24.154633 18762 process.cpp:3671] Handling HTTP event for process 
'master' with path: '/master/api/v1'
I0817 02:23:24.156544 18755 http.cpp:1115] HTTP POST for /master/api/v1 from 
172.17.0.2:33414
I0817 02:23:24.156837 18755 http.cpp:263] Processing call UNRESERVE_RESOURCES
I0817 02:23:24.157552 18755 master.cpp:3890] Authorizing principal 
'test-principal' to unreserve resources 
'[{"disk":{"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf","mount":{"root":"./csi/org.apache.mesos.csi.test/local/mounts"},"profile":"test","type":"MOUNT","vendor":"org.apache.mesos.csi.test.local"}},"name":"disk","provider_id":{"value":"9349c281-1671-4a24-a847-1395b734e595"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I0817 02:23:24.159991 18753 master.cpp:12724] Removing offer 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-O5
I0817 02:23:24.160145 18751 sched.cpp:960] Rescinded offer 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-O5
I0817 02:23:24.160233 18751 sched.cpp:971] Scheduler::offerRescinded took 
28617ns
I0817 02:23:24.160912 18756 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf,test)]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf,test)]:2048,
 allocated: {}) on agent 0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 from framework 
0e44d8e8-aa0c-46
 6c-aab9-36a25cbdabc4-0000
I0817 02:23:24.161033 18756 hierarchical.cpp:1268] Framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 filtered agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 for 5secs
I0817 02:23:24.163700 18752 master.cpp:12615] Sending operation '' (uuid: 
6d67fcec-2918-495e-b708-ac2e4a5a6f14) to agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 at slave(1224)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.164292 18762 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:24.167232 18753 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:24.167285 18753 provider.cpp:1295] Received UNRESERVE operation '' 
(uuid: 6d67fcec-2918-495e-b708-ac2e4a5a6f14)
I0817 02:23:24.173344 18758 http.cpp:1115] HTTP POST for 
/slave(1224)/api/v1/resource_provider from 172.17.0.2:33404
I0817 02:23:24.174398 18761 slave.cpp:8423] Handling resource provider message 
'UPDATE_OPERATION_STATUS: (uuid: aa128e0b-7efb-4ae7-a759-b21d4ea40ee5) for 
framework  (latest state: OPERATION_FINISHED, status update state: 
OPERATION_FINISHED)'
I0817 02:23:24.174595 18761 slave.cpp:8876] Updating the state of operation 
with no ID (uuid: aa128e0b-7efb-4ae7-a759-b21d4ea40ee5) for an operation API 
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0817 02:23:24.174652 18761 slave.cpp:8630] Forwarding status update of 
operation with no ID (operation_uuid: aa128e0b-7efb-4ae7-a759-b21d4ea40ee5) for 
an operator API call
I0817 02:23:24.175063 18760 master.cpp:12271] Updating the state of operation 
'' (uuid: aa128e0b-7efb-4ae7-a759-b21d4ea40ee5) for an operator API call 
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0817 02:23:24.175472 18763 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.382047ms
I0817 02:23:24.175722 18751 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:24.176414 18760 master.cpp:10432] Sending offers [ 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-O6 ] to framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053
I0817 02:23:24.177145 18759 sched.cpp:934] Scheduler::resourceOffers took 
95275ns
I0817 02:23:24.178570 18755 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
059952d4-829f-48aa-a386-7cce26d4fb4e) for operation UUID 
6d67fcec-2918-495e-b708-ac2e4a5a6f14 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.178627 18755 status_update_manager_process.hpp:414] Creating 
operation status update stream 6d67fcec-2918-495e-b708-ac2e4a5a6f14 
checkpoint=true
I0817 02:23:24.178676 18753 provider.cpp:481] Received 
ACKNOWLEDGE_OPERATION_STATUS event
I0817 02:23:24.178894 18755 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: 059952d4-829f-48aa-a386-7cce26d4fb4e) for operation UUID 
6d67fcec-2918-495e-b708-ac2e4a5a6f14 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.195472 18755 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
059952d4-829f-48aa-a386-7cce26d4fb4e) for operation UUID 
6d67fcec-2918-495e-b708-ac2e4a5a6f14 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.195909 18755 status_update_manager_process.hpp:252] Received 
operation status update acknowledgement (UUID: 
34b90631-d8ee-400e-bf33-28ba6833aeea) for stream 
aa128e0b-7efb-4ae7-a759-b21d4ea40ee5
I0817 02:23:24.196007 18755 status_update_manager_process.hpp:929] 
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 
34b90631-d8ee-400e-bf33-28ba6833aeea) for operation UUID 
aa128e0b-7efb-4ae7-a759-b21d4ea40ee5 on agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.196435 18761 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1224)/api/v1/resource_provider
I0817 02:23:24.197360 18763 process.cpp:3671] Handling HTTP event for process 
'slave(1224)' with path: '/slave(1224)/api/v1/resource_provider'
I0817 02:23:24.212323 18755 status_update_manager_process.hpp:490] Cleaning up 
operation status update stream aa128e0b-7efb-4ae7-a759-b21d4ea40ee5
I0817 02:23:24.221895 18760 master.cpp:1412] Framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053 disconnected
I0817 02:23:24.221940 18760 master.cpp:3362] Deactivating framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053
I0817 02:23:24.222314 18749 hierarchical.cpp:475] Deactivated framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000
I0817 02:23:24.222954 18747 slave.cpp:924] Agent terminating
I0817 02:23:24.222988 18760 master.cpp:12724] Removing offer 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-O6
I0817 02:23:24.223071 18760 master.cpp:3339] Disconnecting framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053
I0817 02:23:24.223135 18760 master.cpp:1427] Giving framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053 0ns to failover
I0817 02:23:24.223810 18747 manager.cpp:163] Terminating resource provider 
9349c281-1671-4a24-a847-1395b734e595
I0817 02:23:24.224208 18761 master.cpp:1297] Agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 at slave(1224)@172.17.0.2:46053 
(a1a8a771d01f) disconnected
I0817 02:23:24.224242 18761 master.cpp:3399] Disconnecting agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 at slave(1224)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.224323 18761 master.cpp:3418] Deactivating agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 at slave(1224)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.224243 18749 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf,test)]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v0_sJbyTV/2GB-271ab96b-b358-417b-a2e2-d63c8da133bf,test)]:2048,
 allocated: {}) on agent 0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 from framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000
I0817 02:23:24.224472 18749 hierarchical.cpp:803] Agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0 deactivated
I0817 02:23:24.224560 18761 master.cpp:10224] Framework failover timeout, 
removing framework 0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053
I0817 02:23:24.224604 18761 master.cpp:11223] Removing framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000 (default) at 
[email protected]:46053
I0817 02:23:24.224963 18763 hierarchical.cpp:1434] Allocation paused
E0817 02:23:24.225080 18760 http_connection.hpp:452] End-Of-File received
I0817 02:23:24.225375 18763 hierarchical.cpp:417] Removed framework 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-0000
I0817 02:23:24.225437 18763 hierarchical.cpp:1444] Allocation resumed
I0817 02:23:24.225622 18760 http_connection.hpp:217] Re-detecting endpoint
E0817 02:23:24.225649 18757 provider.cpp:2186] Failed to send status update for 
operation (uuid: 6d67fcec-2918-495e-b708-ac2e4a5a6f14): Disconnected
I0817 02:23:24.226104 18760 http_connection.hpp:338] Ignoring disconnection 
attempt from stale connection
I0817 02:23:24.226194 18754 provider.cpp:471] Disconnected from resource 
provider manager
I0817 02:23:24.226250 18760 http_connection.hpp:227] New endpoint detected at 
http://172.17.0.2:46053/slave(1224)/api/v1/resource_provider
I0817 02:23:24.226408 18755 status_update_manager_process.hpp:379] Pausing 
operation status update manager
I0817 02:23:24.226465 18760 http_connection.hpp:338] Ignoring disconnection 
attempt from stale connection
I0817 02:23:24.227761 18762 containerizer.cpp:2616] Destroying container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 in RUNNING state
I0817 02:23:24.227826 18762 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from RUNNING to DESTROYING after 1.142595968secs
I0817 02:23:24.228277 18762 launcher.cpp:161] Asked to destroy container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:24.229267 18763 hierarchical.cpp:1510] Performed allocation for 1 
agents in 170775ns
I0817 02:23:24.229929 18755 http_connection.hpp:283] Connected with the remote 
endpoint at http://172.17.0.2:46053/slave(1224)/api/v1/resource_provider
I0817 02:23:24.230650 18751 provider.cpp:459] Connected to resource provider 
manager
I0817 02:23:24.231390 18758 http_connection.hpp:131] Sending 1 call to 
http://172.17.0.2:46053/slave(1224)/api/v1/resource_provider
I0817 02:23:24.232208 18764 process.cpp:2781] Returning '404 Not Found' for 
'/slave(1224)/api/v1/resource_provider'
E0817 02:23:24.233455 18763 provider.cpp:702] Failed to subscribe resource 
provider with type 'org.apache.mesos.rp.local.storage' and name 'test': 
Received '404 Not Found' ()
I0817 02:23:24.281579 18760 hierarchical.cpp:1510] Performed allocation for 1 
agents in 191633ns
I0817 02:23:24.331764 18750 containerizer.cpp:3157] Container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 has exited
I0817 02:23:24.333118 18758 hierarchical.cpp:1510] Performed allocation for 1 
agents in 134733ns
I0817 02:23:24.333504 18755 provisioner.cpp:612] Ignoring destroy request for 
unknown container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:24.336163 18762 container_daemon.cpp:189] Invoking post-stop hook 
for container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.336387 18762 service_manager.cpp:723] Disconnected from endpoint 
'unix:///tmp/mesos-csi-NmQtoT/endpoint.sock' of CSI plugin container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:24.336637 18758 container_daemon.cpp:121] Launching container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.339382 18764 process.cpp:2781] Returning '404 Not Found' for 
'/slave(1224)/api/v1'
I0817 02:23:24.350651 18747 master.cpp:1137] Master terminating
I0817 02:23:24.351361 18755 hierarchical.cpp:779] Removed all filters for agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
I0817 02:23:24.351384 18755 hierarchical.cpp:654] Removed agent 
0e44d8e8-aa0c-466c-aab9-36a25cbdabc4-S0
[       OK ] 
CSIVersion/StorageLocalResourceProviderTest.OperatorOperationsWithResourceProviderResources/v0
 (1027 ms)
[ RUN      ] 
CSIVersion/StorageLocalResourceProviderTest.OperatorOperationsWithResourceProviderResources/v1
I0817 02:23:24.370126 18747 cluster.cpp:177] Creating default 'local' authorizer
I0817 02:23:24.374665 18750 master.cpp:440] Master 
df01c76b-8ba7-4784-b400-cfef568aba0c (a1a8a771d01f) started on 172.17.0.2:46053
I0817 02:23:24.374692 18750 master.cpp:443] Flags at startup: --acls="" 
--agent_ping_timeout="15secs" --agent_reregister_timeout="10mins" 
--allocation_interval="50ms" --allocator="hierarchical" 
--authenticate_agents="true" --authenticate_frameworks="true" 
--authenticate_http_frameworks="true" --authenticate_http_readonly="true" 
--authenticate_http_readwrite="true" --authentication_v0_timeout="15secs" 
--authenticators="crammd5" --authorizers="local" 
--credentials="/tmp/TEcAky/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_operator_event_stream_subscribers="1000" 
--max_unreachable_tasks_per_framework="1000" --memory_profiling="false" 
--min_alloca
 table_resources="cpus:0.01|mem:32" --port="5050" 
--publish_per_framework_metrics="true" --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" 
--require_agent_domain="false" --role_sorter="drf" --root_submissions="true" 
--version="false" --webui_dir="/mesos/mesos-1.9.0/_inst/share/mesos/webui" 
--work_dir="/tmp/TEcAky/master" --zk_session_timeout="10secs"
I0817 02:23:24.374989 18750 master.cpp:492] Master only allowing authenticated 
frameworks to register
I0817 02:23:24.375005 18750 master.cpp:498] Master only allowing authenticated 
agents to register
I0817 02:23:24.375018 18750 master.cpp:504] Master only allowing authenticated 
HTTP frameworks to register
I0817 02:23:24.375032 18750 credentials.hpp:37] Loading credentials for 
authentication from '/tmp/TEcAky/credentials'
I0817 02:23:24.375264 18750 master.cpp:548] Using default 'crammd5' 
authenticator
I0817 02:23:24.375450 18750 http.cpp:975] Creating default 'basic' HTTP 
authenticator for realm 'mesos-master-readonly'
I0817 02:23:24.375782 18750 http.cpp:975] Creating default 'basic' HTTP 
authenticator for realm 'mesos-master-readwrite'
I0817 02:23:24.376049 18750 http.cpp:975] Creating default 'basic' HTTP 
authenticator for realm 'mesos-master-scheduler'
I0817 02:23:24.376289 18750 master.cpp:629] Authorization enabled
I0817 02:23:24.376816 18752 hierarchical.cpp:241] Initialized hierarchical 
allocator process
I0817 02:23:24.376948 18748 whitelist_watcher.cpp:77] No whitelist given
I0817 02:23:24.380352 18762 master.cpp:2170] Elected as the leading master!
I0817 02:23:24.380393 18762 master.cpp:1666] Recovering from registrar
I0817 02:23:24.380616 18761 registrar.cpp:339] Recovering registrar
I0817 02:23:24.381328 18761 registrar.cpp:383] Successfully fetched the 
registry (0B) in 0ns
I0817 02:23:24.381446 18761 registrar.cpp:487] Applied 1 operations in 34213ns; 
attempting to update the registry
I0817 02:23:24.382081 18761 registrar.cpp:544] Successfully updated the 
registry in 0ns
I0817 02:23:24.382208 18761 registrar.cpp:416] Successfully recovered registrar
I0817 02:23:24.382746 18748 master.cpp:1819] Recovered 0 agents from the 
registry (143B); allowing 10mins for agents to reregister
I0817 02:23:24.382807 18750 hierarchical.cpp:280] Skipping recovery of 
hierarchical allocator: nothing to recover
W0817 02:23:24.387995 18747 process.cpp:2877] Attempted to spawn already 
running process [email protected]:46053
I0817 02:23:24.389274 18747 containerizer.cpp:318] Using isolation { 
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0817 02:23:24.389825 18747 backend.cpp:76] Failed to create 'overlay' backend: 
OverlayBackend requires root privileges
W0817 02:23:24.389850 18747 backend.cpp:76] Failed to create 'aufs' backend: 
AufsBackend requires root privileges
W0817 02:23:24.389972 18747 backend.cpp:76] Failed to create 'bind' backend: 
BindBackend requires root privileges
I0817 02:23:24.390008 18747 provisioner.cpp:300] Using default backend 'copy'
I0817 02:23:24.392256 18747 cluster.cpp:518] Creating default 'local' authorizer
I0817 02:23:24.394395 18753 slave.cpp:267] Mesos agent started on 
(1225)@172.17.0.2:46053
I0817 02:23:24.394426 18753 slave.cpp:268] Flags at startup: --acls="" 
--appc_simple_discovery_uri_prefix="http://"; 
--appc_store_dir="/tmp/TEcAky/BmVhiQ/store/appc" 
--authenticate_http_readonly="true" --authenticate_http_readwrite="false" 
--authenticatee="crammd5" --authentication_backoff_factor="1secs" 
--authentication_timeout_max="1mins" --authentication_timeout_min="5secs" 
--authorizer="local" --cgroups_cpu_enable_pids_and_tids_count="false" 
--cgroups_destroy_timeout="1mins" --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/TEcAky/BmVhiQ/credential" 
--default_role="*" --disallow_sharing_agent_ipc_namespace="false" 
--disallow_sharing_agent_pid_namespace="false" 
--disk_profile_adaptor="org_apache_mesos_UriDiskProfileAdaptor" 
--disk_watch_interval="1mins" --docker="docker" --docker_ignore_runtime="false" 
--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/TEcAky/BmVhiQ/store/docker" 
--docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" 
--docker_volume_chown="false" --enforce_container_disk_quota="false" 
--executor_registration_timeout="1mins" 
--executor_reregistration_timeout="2secs" 
--executor_shutdown_grace_period="5secs" 
--fetcher_cache_dir="/tmp/TEcAky/BmVhiQ/fetch" --fetcher_cache_size="2GB" 
--fetcher_stall_timeout="1mins" 
--frameworks_home="/tmp/TEcAky/BmVhiQ/frameworks" --gc_delay="1weeks" 
--gc_disk_headroom="0.1" --gc_non_executor_container_sandboxes="false" 
--help="false" --hostname_lookup="true" --http_command_executor="false" 
--http_credentials="/tmp/TEcAky/BmVhiQ/http_credentials" 
--http_heartbeat_interval="30secs" --initialize_driver_logging="true" 
--isolation="posix/cpu,posix/mem" --launcher="posix" 
--launcher_dir="/mesos/mesos-1.9.0/_
 build/src" --logbufsecs="0" --logging_level="INFO" 
--max_completed_executors_per_framework="150" --memory_profiling="false" 
--network_cni_metrics="true" --network_cni_root_dir_persist="false" 
--oversubscribed_resources_interval="15secs" --perf_duration="10secs" 
--perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" 
--quiet="false" --reconfiguration_policy="equal" --recover="reconnect" 
--recovery_timeout="15mins" --registration_backoff_factor="10ms" 
--resource_provider_config_dir="/tmp/TEcAky/resource_provider_configs" 
--resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" 
--revocable_cpu_low_priority="true" 
--runtime_dir="/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_EH62hw"
 --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/CSIVersion_StorageLocalResourcePr
 oviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc" 
--zk_session_timeout="10secs"
I0817 02:23:24.395066 18753 credentials.hpp:86] Loading credential for 
authentication from '/tmp/TEcAky/BmVhiQ/credential'
I0817 02:23:24.395300 18753 slave.cpp:300] Agent using credential for: 
test-principal
I0817 02:23:24.395334 18753 credentials.hpp:37] Loading credentials for 
authentication from '/tmp/TEcAky/BmVhiQ/http_credentials'
I0817 02:23:24.395660 18753 http.cpp:975] Creating default 'basic' HTTP 
authenticator for realm 'mesos-agent-readonly'
I0817 02:23:24.396164 18753 disk_profile_adaptor.cpp:82] Creating disk profile 
adaptor module 'org_apache_mesos_UriDiskProfileAdaptor'
I0817 02:23:24.398178 18753 slave.cpp:615] 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"}]
I0817 02:23:24.398448 18753 slave.cpp:623] Agent attributes: [  ]
I0817 02:23:24.398468 18753 slave.cpp:632] Agent hostname: a1a8a771d01f
I0817 02:23:24.398757 18762 task_status_update_manager.cpp:181] Pausing sending 
task status updates
I0817 02:23:24.398759 18760 status_update_manager_process.hpp:379] Pausing 
operation status update manager
I0817 02:23:24.399300 18763 process.cpp:3671] Handling HTTP event for process 
'test-disk-profile-server' with path: '/test-disk-profile-server/profiles'
I0817 02:23:24.400625 18749 state.cpp:67] Recovering state from 
'/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc/meta'
I0817 02:23:24.400909 18750 slave.cpp:7450] Finished recovering checkpointed 
state from 
'/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc/meta',
 beginning agent recovery
I0817 02:23:24.401599 18758 task_status_update_manager.cpp:207] Recovering task 
status update manager
I0817 02:23:24.402109 18752 containerizer.cpp:821] Recovering Mesos containers
I0817 02:23:24.402549 18752 containerizer.cpp:1157] Recovering isolators
I0817 02:23:24.403713 18763 containerizer.cpp:1196] Recovering provisioner
I0817 02:23:24.403970 18754 uri_disk_profile_adaptor.cpp:305] Updated disk 
profile mapping to 1 active profiles
I0817 02:23:24.404466 18761 provisioner.cpp:500] Provisioner recovery complete
I0817 02:23:24.405377 18758 composing.cpp:339] Finished recovering all 
containerizers
I0817 02:23:24.405731 18762 slave.cpp:7914] Recovering executors
I0817 02:23:24.405899 18762 slave.cpp:8067] Finished recovery
I0817 02:23:24.406833 18763 task_status_update_manager.cpp:181] Pausing sending 
task status updates
I0817 02:23:24.406880 18754 slave.cpp:1351] New master detected at 
[email protected]:46053
I0817 02:23:24.406909 18749 status_update_manager_process.hpp:379] Pausing 
operation status update manager
I0817 02:23:24.407052 18754 slave.cpp:1416] Detecting new master
I0817 02:23:24.408444 18759 slave.cpp:1443] Authenticating with master 
[email protected]:46053
I0817 02:23:24.408562 18759 slave.cpp:1452] Using default CRAM-MD5 authenticatee
I0817 02:23:24.408947 18760 authenticatee.cpp:121] Creating new client SASL 
connection
I0817 02:23:24.409310 18751 master.cpp:10617] Authenticating 
slave(1225)@172.17.0.2:46053
I0817 02:23:24.409477 18750 authenticator.cpp:414] Starting authentication 
session for crammd5-authenticatee(2081)@172.17.0.2:46053
I0817 02:23:24.409768 18748 authenticator.cpp:98] Creating new server SASL 
connection
I0817 02:23:24.409989 18758 authenticatee.cpp:213] Received SASL authentication 
mechanisms: CRAM-MD5
I0817 02:23:24.410030 18758 authenticatee.cpp:239] Attempting to authenticate 
with mechanism 'CRAM-MD5'
I0817 02:23:24.410189 18752 authenticator.cpp:204] Received SASL authentication 
start
I0817 02:23:24.410259 18752 authenticator.cpp:326] Authentication requires more 
steps
I0817 02:23:24.410434 18757 authenticatee.cpp:259] Received SASL authentication 
step
I0817 02:23:24.410625 18756 authenticator.cpp:232] Received SASL authentication 
step
I0817 02:23:24.410676 18756 auxprop.cpp:109] Request to lookup properties for 
user: 'test-principal' realm: 'a1a8a771d01f' server FQDN: 'a1a8a771d01f' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: false 
I0817 02:23:24.410696 18756 auxprop.cpp:181] Looking up auxiliary property 
'*userPassword'
I0817 02:23:24.410753 18756 auxprop.cpp:181] Looking up auxiliary property 
'*cmusaslsecretCRAM-MD5'
I0817 02:23:24.410786 18756 auxprop.cpp:109] Request to lookup properties for 
user: 'test-principal' realm: 'a1a8a771d01f' server FQDN: 'a1a8a771d01f' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: true 
I0817 02:23:24.410801 18756 auxprop.cpp:131] Skipping auxiliary property 
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I0817 02:23:24.410809 18756 auxprop.cpp:131] Skipping auxiliary property 
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0817 02:23:24.410825 18756 authenticator.cpp:318] Authentication success
I0817 02:23:24.410944 18762 authenticatee.cpp:299] Authentication success
I0817 02:23:24.411047 18755 master.cpp:10649] Successfully authenticated 
principal 'test-principal' at slave(1225)@172.17.0.2:46053
I0817 02:23:24.411128 18749 authenticator.cpp:432] Authentication session 
cleanup for crammd5-authenticatee(2081)@172.17.0.2:46053
I0817 02:23:24.411399 18763 slave.cpp:1543] Successfully authenticated with 
master [email protected]:46053
I0817 02:23:24.411798 18763 slave.cpp:1993] Will retry registration in 
9.868704ms if necessary
I0817 02:23:24.411983 18760 master.cpp:7088] Received register agent message 
from slave(1225)@172.17.0.2:46053 (a1a8a771d01f)
I0817 02:23:24.412333 18760 master.cpp:4204] Authorizing agent providing 
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 
'test-principal'
I0817 02:23:24.413055 18748 master.cpp:7155] Authorized registration of agent 
at slave(1225)@172.17.0.2:46053 (a1a8a771d01f)
I0817 02:23:24.413156 18748 master.cpp:7267] Registering agent at 
slave(1225)@172.17.0.2:46053 (a1a8a771d01f) with id 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.413810 18752 registrar.cpp:487] Applied 1 operations in 
196316ns; attempting to update the registry
I0817 02:23:24.414547 18752 registrar.cpp:544] Successfully updated the 
registry in 0ns
I0817 02:23:24.414741 18753 master.cpp:7315] Admitted agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.415588 18753 master.cpp:7360] Registered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0817 02:23:24.415709 18762 slave.cpp:1576] Registered with master 
[email protected]:46053; given agent ID df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.415755 18761 hierarchical.cpp:621] Added agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 (a1a8a771d01f) with cpus:2; mem:1024; 
disk:1024; ports:[31000-32000] (allocated: {})
I0817 02:23:24.415829 18763 task_status_update_manager.cpp:188] Resuming 
sending task status updates
I0817 02:23:24.416127 18761 hierarchical.cpp:1510] Performed allocation for 1 
agents in 167617ns
I0817 02:23:24.416188 18762 slave.cpp:1611] Checkpointing SlaveInfo to 
'/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc/meta/slaves/df01c76b-8ba7-4784-b400-cfef568aba0c-S0/slave.info'
I0817 02:23:24.416273 18751 status_update_manager_process.hpp:385] Resuming 
operation status update manager
I0817 02:23:24.417239 18762 slave.cpp:1663] Forwarding agent update 
{"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"tGcErJkPRsOzEtO418h5QA=="},"slave_id":{"value":"df01c76b-8ba7-4784-b400-cfef568aba0c-S0"},"update_oversubscribed_resources":false}
I0817 02:23:24.417872 18755 master.cpp:8487] Ignoring update on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f) as it reports no changes
I0817 02:23:24.421907 18758 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1'
I0817 02:23:24.423236 18755 http.cpp:1115] HTTP POST for /slave(1225)/api/v1 
from 172.17.0.2:33424
I0817 02:23:24.423657 18755 http.cpp:2146] Processing GET_CONTAINERS call
I0817 02:23:24.428898 18755 container_daemon.cpp:121] Launching container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.431277 18763 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1'
I0817 02:23:24.432379 18762 http.cpp:1115] HTTP POST for /slave(1225)/api/v1 
from 172.17.0.2:33426
I0817 02:23:24.433223 18762 http.cpp:2606] Processing LAUNCH_CONTAINER call for 
container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.434096 18757 http.cpp:2710] Creating sandbox 
'/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.434803 18755 containerizer.cpp:1392] Starting container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:24.435328 18755 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from STARTING to PROVISIONING after 0ns
I0817 02:23:24.435976 18755 containerizer.cpp:1570] Checkpointed 
ContainerConfig at 
'/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_EH62hw/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config'
I0817 02:23:24.436023 18755 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from PROVISIONING to PREPARING after 0ns
I0817 02:23:24.438916 18748 containerizer.cpp:2096] Launching 
'mesos-containerizer' with flags '--help="false" 
--launch_info="{"command":{"arguments":["/mesos/mesos-1.9.0/_build/src/test-csi-plugin","--api_version=v1","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS","--available_capacity=2GB","--volumes=","","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.9.0/_build/src/test-csi-plugin"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"},{"name":"CSI_ENDPOINT","type":"VALUE","value":"unix:///tmp/mesos-csi-Dn1rF8/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperat
 
ionsWithResourceProviderResources_v1_T2VOhc/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}"
 --pipe_read="90" --pipe_write="91" 
--runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_EH62hw/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"
 --unshare_namespace_mnt="false"'
I0817 02:23:24.447901 18748 launcher.cpp:145] Forked child with pid '29988' for 
container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.449117 18748 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from PREPARING to ISOLATING after 0ns
I0817 02:23:24.450911 18761 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from ISOLATING to FETCHING after 0ns
I0817 02:23:24.451267 18753 fetcher.cpp:369] Starting to fetch URIs for 
container: 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE,
 directory: 
/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_T2VOhc/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:24.452451 18750 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from FETCHING to RUNNING after 0ns
I0817 02:23:24.455200 18752 container_daemon.cpp:140] Invoking post-start hook 
for container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.455345 18756 service_manager.cpp:703] Connecting to endpoint 
'unix:///tmp/mesos-csi-Dn1rF8/endpoint.sock' of CSI plugin container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:24.461200 18750 hierarchical.cpp:1510] Performed allocation for 1 
agents in 188274ns
I0817 02:23:24.512060 18758 hierarchical.cpp:1510] Performed allocation for 1 
agents in 127232ns
I0817 02:23:24.562707 18753 hierarchical.cpp:1510] Performed allocation for 1 
agents in 134919ns
I0817 02:23:24.614243 18754 hierarchical.cpp:1510] Performed allocation for 1 
agents in 224964ns
I0817 02:23:24.665683 18760 hierarchical.cpp:1510] Performed allocation for 1 
agents in 227644ns
I0817 02:23:24.717564 18763 hierarchical.cpp:1510] Performed allocation for 1 
agents in 198954ns
I0817 02:23:24.761335 18752 service_manager.cpp:545] Probing endpoint 
'unix:///tmp/mesos-csi-Dn1rF8/endpoint.sock' with CSI v1
I0817 02:23:24.768939 18756 hierarchical.cpp:1510] Performed allocation for 1 
agents in 136276ns
I0817 02:23:24.778329 29992 test_csi_plugin.cpp:909] ProbeRequest '{}'
I0817 02:23:24.780220 18761 container_daemon.cpp:171] Waiting for container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.783416 29992 test_csi_plugin.cpp:895] 
GetPluginCapabilitiesRequest '{}'
I0817 02:23:24.783751 18758 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1'
I0817 02:23:24.785254 18761 http.cpp:1115] HTTP POST for /slave(1225)/api/v1 
from 172.17.0.2:33428
I0817 02:23:24.785776 18761 http.cpp:2824] Processing WAIT_CONTAINER call for 
container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:24.787261 29992 test_csi_plugin.cpp:877] GetPluginInfoRequest '{}'
I0817 02:23:24.787688 29993 test_csi_plugin.cpp:877] GetPluginInfoRequest '{}'
I0817 02:23:24.789371 18752 v1_volume_manager.cpp:649] NODE_SERVICE loaded: 
{"name":".","vendorVersion":"1.9.0"}
I0817 02:23:24.789958 18752 v1_volume_manager.cpp:649] CONTROLLER_SERVICE 
loaded: {"name":".","vendorVersion":"1.9.0"}
I0817 02:23:24.792191 29994 test_csi_plugin.cpp:1105] 
ControllerGetCapabilitiesRequest '{}'
I0817 02:23:24.795686 29992 test_csi_plugin.cpp:1241] 
NodeGetCapabilitiesRequest '{}'
I0817 02:23:24.798924 29992 test_csi_plugin.cpp:1255] NodeGetInfoRequest '{}'
I0817 02:23:24.800902 18753 provider.cpp:659] Finished recovery for resource 
provider with type 'org.apache.mesos.rp.local.storage' and name 'test'
I0817 02:23:24.801077 18755 status_update_manager_process.hpp:379] Pausing 
operation status update manager
I0817 02:23:24.801466 18761 http_connection.hpp:227] New endpoint detected at 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:24.804523 18759 http_connection.hpp:283] Connected with the remote 
endpoint at http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:24.805224 18752 provider.cpp:459] Connected to resource provider 
manager
I0817 02:23:24.805873 18755 http_connection.hpp:131] Sending 1 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:24.806972 18761 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:24.808789 18749 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33432
I0817 02:23:24.809530 18762 manager.cpp:807] Subscribing resource provider 
{"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.9.0/_build/src/test-csi-plugin","--api_version=v1","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS","--available_capacity=2GB","--volumes=","","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.9.0/_build/src/test-csi-plugin"},"resources":[{"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}],"services":["CONTROLLER_SERVICE","NODE_SERVICE"]}],"name":"local","type":"org.apache.mesos.csi.test"}},"type":"org.apache.mesos.rp.local.storage"}
I0817 02:23:24.812479 18761 slave.cpp:8423] Handling resource provider message 
'SUBSCRIBE: 
{"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"a7f8a9d4-1268-4cc2-92b7-d1e217583e4a"},"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.9.0/_build/src/test-csi-plugin","--api_version=v1","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS","--available_capacity=2GB","--volumes=","","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.9.0/_build/src/test-csi-plugin"},"resources":[{"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}],"services":["CONTROLLER_SERVICE","NODE_SERVICE"]}],"name":"local","type":"org.apache.mesos.csi.test"}},"type":"org.apache.mesos.rp.local.storage"}'
I0817 02:23:24.814168 18759 provider.cpp:481] Received SUBSCRIBED event
I0817 02:23:24.814210 18759 provider.cpp:1255] Subscribed with ID 
a7f8a9d4-1268-4cc2-92b7-d1e217583e4a
I0817 02:23:24.815037 18760 status_update_manager_process.hpp:314] Recovering 
operation status update manager
I0817 02:23:24.820205 18756 hierarchical.cpp:1510] Performed allocation for 1 
agents in 168790ns
I0817 02:23:24.823359 29992 test_csi_plugin.cpp:1050] ListVolumesRequest '{}'
I0817 02:23:24.825610 18755 provider.cpp:2145] Sending UPDATE_STATE call with 
resources '{}' and 0 operations to agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.825801 18755 provider.cpp:745] Resource provider 
a7f8a9d4-1268-4cc2-92b7-d1e217583e4a is in READY state
I0817 02:23:24.825850 18760 status_update_manager_process.hpp:385] Resuming 
operation status update manager
I0817 02:23:24.825868 18759 http_connection.hpp:131] Sending 3 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:24.826510 18763 provider.cpp:1181] Updating profiles { test } for 
resource provider a7f8a9d4-1268-4cc2-92b7-d1e217583e4a
I0817 02:23:24.826998 18750 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:24.828915 18756 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33430
I0817 02:23:24.829463 18752 manager.cpp:1039] Received UPDATE_STATE call with 
resources '[]' and 0 operations from resource provider 
a7f8a9d4-1268-4cc2-92b7-d1e217583e4a
I0817 02:23:24.829715 18758 slave.cpp:8423] Handling resource provider message 
'UPDATE_STATE: a7f8a9d4-1268-4cc2-92b7-d1e217583e4a {}'
I0817 02:23:24.829825 18758 slave.cpp:8543] Forwarding new total resources 
cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0817 02:23:24.830516 29992 test_csi_plugin.cpp:1078] GetCapacityRequest 
'{"volumeCapabilities":[{"mount":{},"accessMode":{"mode":"SINGLE_NODE_WRITER"}}]}'
I0817 02:23:24.831790 18760 hierarchical.cpp:757] Grew agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 by {} (total), {  } (used)
I0817 02:23:24.832231 18760 hierarchical.cpp:714] Agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 (a1a8a771d01f) updated with total 
resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
W0817 02:23:24.833372 18747 process.cpp:2877] Attempted to spawn already 
running process [email protected]:46053
I0817 02:23:24.834682 18747 sched.cpp:239] Version: 1.9.0
I0817 02:23:24.834858 18749 provider.cpp:933] Removing '{}' and adding 
'disk(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048' to the 
total resources
I0817 02:23:24.835546 18761 sched.cpp:343] New master detected at 
[email protected]:46053
I0817 02:23:24.835711 18761 sched.cpp:408] Authenticating with master 
[email protected]:46053
I0817 02:23:24.835738 18761 sched.cpp:415] Using default CRAM-MD5 authenticatee
I0817 02:23:24.836138 18751 authenticatee.cpp:121] Creating new client SASL 
connection
I0817 02:23:24.836542 18760 master.cpp:10617] Authenticating 
[email protected]:46053
I0817 02:23:24.836733 18755 authenticator.cpp:414] Starting authentication 
session for crammd5-authenticatee(2082)@172.17.0.2:46053
I0817 02:23:24.836735 18749 provider.cpp:2145] Sending UPDATE_STATE call with 
resources 'disk(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048' and 0 
operations to agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.836735 18759 hierarchical.cpp:1510] Performed allocation for 1 
agents in 160872ns
I0817 02:23:24.837121 18756 authenticator.cpp:98] Creating new server SASL 
connection
I0817 02:23:24.837193 18754 http_connection.hpp:131] Sending 3 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:24.837404 18752 authenticatee.cpp:213] Received SASL authentication 
mechanisms: CRAM-MD5
I0817 02:23:24.837442 18752 authenticatee.cpp:239] Attempting to authenticate 
with mechanism 'CRAM-MD5'
I0817 02:23:24.837643 18748 authenticator.cpp:204] Received SASL authentication 
start
I0817 02:23:24.837711 18748 authenticator.cpp:326] Authentication requires more 
steps
I0817 02:23:24.837862 18753 authenticatee.cpp:259] Received SASL authentication 
step
I0817 02:23:24.838052 18762 authenticator.cpp:232] Received SASL authentication 
step
I0817 02:23:24.838089 18762 auxprop.cpp:109] Request to lookup properties for 
user: 'test-principal' realm: 'a1a8a771d01f' server FQDN: 'a1a8a771d01f' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: false 
I0817 02:23:24.838109 18762 auxprop.cpp:181] Looking up auxiliary property 
'*userPassword'
I0817 02:23:24.838166 18762 auxprop.cpp:181] Looking up auxiliary property 
'*cmusaslsecretCRAM-MD5'
I0817 02:23:24.838210 18762 auxprop.cpp:109] Request to lookup properties for 
user: 'test-principal' realm: 'a1a8a771d01f' server FQDN: 'a1a8a771d01f' 
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false 
SASL_AUXPROP_AUTHZID: true 
I0817 02:23:24.838239 18762 auxprop.cpp:131] Skipping auxiliary property 
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I0817 02:23:24.838259 18762 auxprop.cpp:131] Skipping auxiliary property 
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0817 02:23:24.838289 18762 authenticator.cpp:318] Authentication success
I0817 02:23:24.838346 18751 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:24.838536 18757 authenticatee.cpp:299] Authentication success
I0817 02:23:24.838573 18760 master.cpp:10649] Successfully authenticated 
principal 'test-principal' at 
[email protected]:46053
I0817 02:23:24.838585 18762 authenticator.cpp:432] Authentication session 
cleanup for crammd5-authenticatee(2082)@172.17.0.2:46053
I0817 02:23:24.838963 18759 sched.cpp:520] Successfully authenticated with 
master [email protected]:46053
I0817 02:23:24.838992 18759 sched.cpp:835] Sending SUBSCRIBE call to 
[email protected]:46053
I0817 02:23:24.839164 18759 sched.cpp:870] Will retry registration in 
138.103364ms if necessary
I0817 02:23:24.839447 18749 master.cpp:2910] Received SUBSCRIBE call for 
framework 'default' at 
[email protected]:46053
I0817 02:23:24.839504 18749 master.cpp:2242] Authorizing framework principal 
'test-principal' to receive offers for roles '{ storage/default-role }'
I0817 02:23:24.840163 18754 master.cpp:2997] Subscribing framework default with 
checkpointing disabled and capabilities [ MULTI_ROLE, RESERVATION_REFINEMENT ]
I0817 02:23:24.844453 18754 master.cpp:10847] Adding framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053 with roles {  } 
suppressed
I0817 02:23:24.845041 18763 sched.cpp:751] Framework registered with 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.845099 18763 sched.cpp:770] Scheduler::registered took 29368ns
I0817 02:23:24.845441 18758 hierarchical.cpp:368] Added framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.846753 18758 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.144879ms
I0817 02:23:24.847295 18751 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O0 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:24.847911 18761 sched.cpp:934] Scheduler::resourceOffers took 
125454ns
I0817 02:23:24.848289 18760 master.cpp:6224] Processing DECLINE call for 
offers: [ df01c76b-8ba7-4784-b400-cfef568aba0c-O0 ] for framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053 with 5 seconds 
filter
I0817 02:23:24.848857 18760 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O0
I0817 02:23:24.849498 18752 hierarchical.cpp:1222] Recovered cpus(allocated: 
storage/default-role):2; mem(allocated: storage/default-role):1024; 
disk(allocated: storage/default-role):1024; ports(allocated: 
storage/default-role):[31000-32000] (total: cpus:2; mem:1024; disk:1024; 
ports:[31000-32000], allocated: {}) on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.849565 18752 hierarchical.cpp:1268] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 filtered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for 5secs
I0817 02:23:24.881606 18748 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33430
I0817 02:23:24.882251 18748 manager.cpp:1039] Received UPDATE_STATE call with 
resources 
'[{"disk":{"source":{"profile":"test","type":"RAW","vendor":"org.apache.mesos.csi.test.local"}},"name":"disk","provider_id":{"value":"a7f8a9d4-1268-4cc2-92b7-d1e217583e4a"},"reservations":[{"role":"storage","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
 and 0 operations from resource provider a7f8a9d4-1268-4cc2-92b7-d1e217583e4a
I0817 02:23:24.882836 18753 slave.cpp:8423] Handling resource provider message 
'UPDATE_STATE: a7f8a9d4-1268-4cc2-92b7-d1e217583e4a disk(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048'
I0817 02:23:24.882985 18753 slave.cpp:8543] Forwarding new total resources 
cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048
I0817 02:23:24.885448 18751 hierarchical.cpp:714] Agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 (a1a8a771d01f) updated with total 
resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048
I0817 02:23:24.886960 18751 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.285078ms
I0817 02:23:24.887723 18761 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O1 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:24.888368 18761 sched.cpp:934] Scheduler::resourceOffers took 
80054ns
I0817 02:23:24.892177 18757 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O1
I0817 02:23:24.892621 18757 master.cpp:4741] Processing ACCEPT call for offers: 
[ df01c76b-8ba7-4784-b400-cfef568aba0c-O1 ] on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f) for framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000 
(default) at [email protected]:46053
I0817 02:23:24.892648 18759 hierarchical.cpp:1510] Performed allocation for 1 
agents in 261095ns
I0817 02:23:24.892745 18757 master.cpp:4114] Authorizing principal 
'test-principal' to create a MOUNT disk from 'disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048'
I0817 02:23:24.893939 18753 master.cpp:6016] Processing CREATE_DISK operation 
with source disk(allocated: storage/default-role)(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048 from 
framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053 to agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.894546 18753 master.cpp:12615] Sending operation '' (uuid: 
efc03650-7f13-422f-aae4-d1f12c3f262f) to agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:24.894981 18756 hierarchical.cpp:1434] Allocation paused
I0817 02:23:24.895117 18758 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:24.896332 18756 hierarchical.cpp:1222] Recovered ports(allocated: 
storage/default-role):[31000-32000]; cpus(allocated: storage/default-role):2; 
mem(allocated: storage/default-role):1024; disk(allocated: 
storage/default-role):1024 (total: cpus:2; mem:1024; disk:1024; 
ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048, 
allocated: disk(allocated: storage/default-role)(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048) on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.896441 18756 hierarchical.cpp:1268] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 filtered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for 5secs
I0817 02:23:24.896661 18756 hierarchical.cpp:1444] Allocation resumed
I0817 02:23:24.897521 18757 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:24.897567 18757 provider.cpp:1295] Received CREATE_DISK operation 
'' (uuid: efc03650-7f13-422f-aae4-d1f12c3f262f)
I0817 02:23:24.900203 18749 v1_volume_manager.cpp:293] Creating volume with 
name 'efc03650-7f13-422f-aae4-d1f12c3f262f'
I0817 02:23:24.902808 29992 test_csi_plugin.cpp:922] CreateVolumeRequest 
'{"name":"efc03650-7f13-422f-aae4-d1f12c3f262f","capacityRange":{"requiredBytes":"2147483648","limitBytes":"2147483648"},"volumeCapabilities":[{"mount":{},"accessMode":{"mode":"SINGLE_NODE_WRITER"}}]}'
I0817 02:23:24.916010 18761 provider.cpp:1597] Applying conversion from 
'disk(allocated: storage/default-role)(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048' to 
'disk(allocated: storage/default-role)(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048'
 for operation (uuid: efc03650-7f13-422f-aae4-d1f12c3f262f)
I0817 02:23:24.924526 18752 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
96bafeab-3b95-434a-8ebb-cc7e88bd4e5a) for operation UUID 
efc03650-7f13-422f-aae4-d1f12c3f262f of framework 
'df01c76b-8ba7-4784-b400-cfef568aba0c-0000' on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.924612 18752 status_update_manager_process.hpp:414] Creating 
operation status update stream efc03650-7f13-422f-aae4-d1f12c3f262f 
checkpoint=true
I0817 02:23:24.924964 18752 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: 96bafeab-3b95-434a-8ebb-cc7e88bd4e5a) for operation UUID 
efc03650-7f13-422f-aae4-d1f12c3f262f of framework 
'df01c76b-8ba7-4784-b400-cfef568aba0c-0000' on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.941335 18752 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
96bafeab-3b95-434a-8ebb-cc7e88bd4e5a) for operation UUID 
efc03650-7f13-422f-aae4-d1f12c3f262f of framework 
'df01c76b-8ba7-4784-b400-cfef568aba0c-0000' on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.942409 18759 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:24.943845 18749 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:24.944032 18757 hierarchical.cpp:2360] Filtered offer with cpus:2; 
mem:1024; disk:1024; ports:[31000-32000] on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for role storage/default-role of 
framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.944195 18757 hierarchical.cpp:1510] Performed allocation for 1 
agents in 773870ns
I0817 02:23:24.985873 18760 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33430
I0817 02:23:24.986999 18761 slave.cpp:8423] Handling resource provider message 
'UPDATE_OPERATION_STATUS: (uuid: efc03650-7f13-422f-aae4-d1f12c3f262f) for 
framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (latest state: 
OPERATION_FINISHED, status update state: OPERATION_FINISHED)'
I0817 02:23:24.987206 18761 slave.cpp:8876] Updating the state of operation 
with no ID (uuid: efc03650-7f13-422f-aae4-d1f12c3f262f) for framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (latest state: OPERATION_FINISHED, 
status update state: OPERATION_FINISHED)
I0817 02:23:24.987646 18761 slave.cpp:8630] Forwarding status update of 
operation with no ID (operation_uuid: efc03650-7f13-422f-aae4-d1f12c3f262f) for 
framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.988011 18762 master.cpp:12271] Updating the state of operation 
'' (uuid: efc03650-7f13-422f-aae4-d1f12c3f262f) for framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (latest state: OPERATION_PENDING, 
status update state: OPERATION_FINISHED)
I0817 02:23:24.989907 18763 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:24.990181 18759 hierarchical.cpp:960] Updated allocation of 
framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:2048 to 
disk(allocated: storage/default-role)(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048
I0817 02:23:24.991103 18759 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048
 (total: cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048,
 allocated: {}) on agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:24.991597 18760 provider.cpp:481] Received 
ACKNOWLEDGE_OPERATION_STATUS event
I0817 02:23:24.991786 18756 status_update_manager_process.hpp:252] Received 
operation status update acknowledgement (UUID: 
96bafeab-3b95-434a-8ebb-cc7e88bd4e5a) for stream 
efc03650-7f13-422f-aae4-d1f12c3f262f
I0817 02:23:24.991902 18756 status_update_manager_process.hpp:929] 
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 
96bafeab-3b95-434a-8ebb-cc7e88bd4e5a) for operation UUID 
efc03650-7f13-422f-aae4-d1f12c3f262f of framework 
'df01c76b-8ba7-4784-b400-cfef568aba0c-0000' on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:24.997012 18754 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.492546ms
I0817 02:23:24.997769 18752 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O2 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:24.998613 18752 sched.cpp:934] Scheduler::resourceOffers took 
148366ns
I0817 02:23:25.000773 18756 status_update_manager_process.hpp:490] Cleaning up 
operation status update stream efc03650-7f13-422f-aae4-d1f12c3f262f
I0817 02:23:25.002859 18758 process.cpp:3671] Handling HTTP event for process 
'master' with path: '/master/api/v1'
I0817 02:23:25.005044 18757 http.cpp:1115] HTTP POST for /master/api/v1 from 
172.17.0.2:33434
I0817 02:23:25.005358 18757 http.cpp:263] Processing call RESERVE_RESOURCES
I0817 02:23:25.006172 18757 master.cpp:3826] Authorizing principal 
'test-principal' to reserve resources 'disk(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048'
I0817 02:23:25.008496 18748 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O2
I0817 02:23:25.008626 18755 sched.cpp:960] Rescinded offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O2
I0817 02:23:25.008780 18755 sched.cpp:971] Scheduler::offerRescinded took 
26647ns
I0817 02:23:25.009557 18751 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048,
 allocated: {}) on agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:25.009667 18751 hierarchical.cpp:1268] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 filtered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for 5secs
I0817 02:23:25.012172 18761 master.cpp:12615] Sending operation '' (uuid: 
bebd4261-e398-4941-831a-6505eaba6f9e) to agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:25.012696 18752 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.015398 18758 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:25.015441 18758 provider.cpp:1295] Received RESERVE operation '' 
(uuid: bebd4261-e398-4941-831a-6505eaba6f9e)
I0817 02:23:25.015890 18755 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.194584ms
I0817 02:23:25.016711 18760 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O3 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.017436 18762 sched.cpp:934] Scheduler::resourceOffers took 
81092ns
I0817 02:23:25.027237 18750 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
37e4a855-f982-4764-8a48-f317e5c94c9e) for operation UUID 
bebd4261-e398-4941-831a-6505eaba6f9e on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.027298 18750 status_update_manager_process.hpp:414] Creating 
operation status update stream bebd4261-e398-4941-831a-6505eaba6f9e 
checkpoint=true
I0817 02:23:25.027588 18750 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: 37e4a855-f982-4764-8a48-f317e5c94c9e) for operation UUID 
bebd4261-e398-4941-831a-6505eaba6f9e on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.044015 18750 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
37e4a855-f982-4764-8a48-f317e5c94c9e) for operation UUID 
bebd4261-e398-4941-831a-6505eaba6f9e on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.044929 18753 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.046048 18749 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:25.048821 18756 process.cpp:3671] Handling HTTP event for process 
'master' with path: '/master/api/v1'
I0817 02:23:25.050737 18762 http.cpp:1115] HTTP POST for /master/api/v1 from 
172.17.0.2:33436
I0817 02:23:25.051003 18762 http.cpp:263] Processing call CREATE_VOLUMES
I0817 02:23:25.051868 18762 master.cpp:3953] Authorizing principal 
'test-principal' to create volumes 
'[{"disk":{"persistence":{"id":"cfbaf0b0-32ad-4504-a36e-1c107d760412","principal":"test-principal"},"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f","mount":{"root":"./csi/org.apache.mesos.csi.test/local/mounts"},"profile":"test","type":"MOUNT","vendor":"org.apache.mesos.csi.test.local"},"volume":{"container_path":"volume","mode":"RW"}},"name":"disk","provider_id":{"value":"a7f8a9d4-1268-4cc2-92b7-d1e217583e4a"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I0817 02:23:25.054072 18754 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O3
I0817 02:23:25.054215 18763 sched.cpp:960] Rescinded offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O3
I0817 02:23:25.054297 18763 sched.cpp:971] Scheduler::offerRescinded took 
23299ns
I0817 02:23:25.055011 18752 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048,
 allocated: {}) on agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-47
 84-b400-cfef568aba0c-0000
I0817 02:23:25.055133 18752 hierarchical.cpp:1268] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 filtered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for 5secs
I0817 02:23:25.057840 18749 master.cpp:12615] Sending operation '' (uuid: 
9d7c1a38-64d2-445e-9ca6-85a0c027fd23) to agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:25.058506 18749 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.061791 18754 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:25.061832 18754 provider.cpp:1295] Received CREATE operation '' 
(uuid: 9d7c1a38-64d2-445e-9ca6-85a0c027fd23)
I0817 02:23:25.067350 18761 master.cpp:6417] Processing REVIVE call for 
framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.067853 18761 hierarchical.cpp:1375] Unsuppressed offers and 
cleared filters for roles { storage/default-role } of framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:25.069310 18761 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.283042ms
I0817 02:23:25.069758 18761 hierarchical.cpp:1510] Performed allocation for 1 
agents in 227054ns
I0817 02:23:25.070103 18757 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O4 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.070775 18759 sched.cpp:934] Scheduler::resourceOffers took 
78448ns
I0817 02:23:25.073247 18760 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
b83f7a63-f122-45bb-b99e-02d5e9965d41) for operation UUID 
9d7c1a38-64d2-445e-9ca6-85a0c027fd23 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.073325 18760 status_update_manager_process.hpp:414] Creating 
operation status update stream 9d7c1a38-64d2-445e-9ca6-85a0c027fd23 
checkpoint=true
I0817 02:23:25.073606 18760 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: b83f7a63-f122-45bb-b99e-02d5e9965d41) for operation UUID 
9d7c1a38-64d2-445e-9ca6-85a0c027fd23 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.089125 18750 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33430
I0817 02:23:25.089838 18760 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
b83f7a63-f122-45bb-b99e-02d5e9965d41) for operation UUID 
9d7c1a38-64d2-445e-9ca6-85a0c027fd23 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.090020 18763 slave.cpp:8423] Handling resource provider message 
'UPDATE_OPERATION_STATUS: (uuid: bebd4261-e398-4941-831a-6505eaba6f9e) for 
framework  (latest state: OPERATION_FINISHED, status update state: 
OPERATION_FINISHED)'
I0817 02:23:25.090171 18763 slave.cpp:8876] Updating the state of operation 
with no ID (uuid: bebd4261-e398-4941-831a-6505eaba6f9e) for an operation API 
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0817 02:23:25.090212 18763 slave.cpp:8630] Forwarding status update of 
operation with no ID (operation_uuid: bebd4261-e398-4941-831a-6505eaba6f9e) for 
an operator API call
I0817 02:23:25.090577 18751 master.cpp:12271] Updating the state of operation 
'' (uuid: bebd4261-e398-4941-831a-6505eaba6f9e) for an operator API call 
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0817 02:23:25.090833 18761 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.091130 18759 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.092187 18750 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:25.092542 18760 provider.cpp:481] Received 
ACKNOWLEDGE_OPERATION_STATUS event
I0817 02:23:25.092775 18751 status_update_manager_process.hpp:252] Received 
operation status update acknowledgement (UUID: 
37e4a855-f982-4764-8a48-f317e5c94c9e) for stream 
bebd4261-e398-4941-831a-6505eaba6f9e
I0817 02:23:25.092855 18751 status_update_manager_process.hpp:929] 
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 
37e4a855-f982-4764-8a48-f317e5c94c9e) for operation UUID 
bebd4261-e398-4941-831a-6505eaba6f9e on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.106575 18751 status_update_manager_process.hpp:490] Cleaning up 
operation status update stream bebd4261-e398-4941-831a-6505eaba6f9e
I0817 02:23:25.118528 18761 process.cpp:3671] Handling HTTP event for process 
'master' with path: '/master/api/v1'
I0817 02:23:25.120301 18755 http.cpp:1115] HTTP POST for /master/api/v1 from 
172.17.0.2:33438
I0817 02:23:25.120565 18755 http.cpp:263] Processing call DESTROY_VOLUMES
I0817 02:23:25.121618 18755 master.cpp:3998] Authorizing principal 
'test-principal' to destroy volumes 
'[{"disk":{"persistence":{"id":"cfbaf0b0-32ad-4504-a36e-1c107d760412","principal":"test-principal"},"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f","mount":{"root":"./csi/org.apache.mesos.csi.test/local/mounts"},"profile":"test","type":"MOUNT","vendor":"org.apache.mesos.csi.test.local"},"volume":{"container_path":"volume","mode":"RW"}},"name":"disk","provider_id":{"value":"a7f8a9d4-1268-4cc2-92b7-d1e217583e4a"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I0817 02:23:25.123952 18757 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O4
I0817 02:23:25.124159 18759 sched.cpp:960] Rescinded offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O4
I0817 02:23:25.124241 18759 sched.cpp:971] Scheduler::offerRescinded took 
23209ns
I0817 02:23:25.124755 18760 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test),cfbaf0b0-32ad-4504-a36e-1c107d760412:volume]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test),cfbaf0b0-32ad-4504-a36e-1c107d760412:volume]:2048,
 allocat
 ed: {}) on agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:25.124853 18760 hierarchical.cpp:1268] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 filtered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for 5secs
I0817 02:23:25.127326 18751 master.cpp:12615] Sending operation '' (uuid: 
86cd5132-97ed-4c0d-b404-230c7a350dc8) to agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:25.127847 18751 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.130909 18759 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:25.130951 18759 provider.cpp:1295] Received DESTROY operation '' 
(uuid: 86cd5132-97ed-4c0d-b404-230c7a350dc8)
I0817 02:23:25.133409 18758 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33430
I0817 02:23:25.134166 18753 slave.cpp:8423] Handling resource provider message 
'UPDATE_OPERATION_STATUS: (uuid: 9d7c1a38-64d2-445e-9ca6-85a0c027fd23) for 
framework  (latest state: OPERATION_FINISHED, status update state: 
OPERATION_FINISHED)'
I0817 02:23:25.134369 18753 slave.cpp:8876] Updating the state of operation 
with no ID (uuid: 9d7c1a38-64d2-445e-9ca6-85a0c027fd23) for an operation API 
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0817 02:23:25.134430 18753 slave.cpp:8630] Forwarding status update of 
operation with no ID (operation_uuid: 9d7c1a38-64d2-445e-9ca6-85a0c027fd23) for 
an operator API call
I0817 02:23:25.134799 18752 master.cpp:12271] Updating the state of operation 
'' (uuid: 9d7c1a38-64d2-445e-9ca6-85a0c027fd23) for an operator API call 
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0817 02:23:25.135367 18763 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.139415 18753 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.316078ms
I0817 02:23:25.140137 18751 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O5 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.140774 18751 sched.cpp:934] Scheduler::resourceOffers took 
79642ns
I0817 02:23:25.142851 18757 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
40c93524-59ad-476b-bf1c-485bddb761ed) for operation UUID 
86cd5132-97ed-4c0d-b404-230c7a350dc8 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.142927 18757 status_update_manager_process.hpp:414] Creating 
operation status update stream 86cd5132-97ed-4c0d-b404-230c7a350dc8 
checkpoint=true
I0817 02:23:25.142944 18759 provider.cpp:481] Received 
ACKNOWLEDGE_OPERATION_STATUS event
I0817 02:23:25.143189 18757 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: 40c93524-59ad-476b-bf1c-485bddb761ed) for operation UUID 
86cd5132-97ed-4c0d-b404-230c7a350dc8 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.159523 18757 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
40c93524-59ad-476b-bf1c-485bddb761ed) for operation UUID 
86cd5132-97ed-4c0d-b404-230c7a350dc8 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.159884 18757 status_update_manager_process.hpp:252] Received 
operation status update acknowledgement (UUID: 
b83f7a63-f122-45bb-b99e-02d5e9965d41) for stream 
9d7c1a38-64d2-445e-9ca6-85a0c027fd23
I0817 02:23:25.159973 18757 status_update_manager_process.hpp:929] 
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 
b83f7a63-f122-45bb-b99e-02d5e9965d41) for operation UUID 
9d7c1a38-64d2-445e-9ca6-85a0c027fd23 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.160432 18755 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.161428 18760 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:25.176184 18757 status_update_manager_process.hpp:490] Cleaning up 
operation status update stream 9d7c1a38-64d2-445e-9ca6-85a0c027fd23
I0817 02:23:25.188433 18754 process.cpp:3671] Handling HTTP event for process 
'master' with path: '/master/api/v1'
I0817 02:23:25.190367 18751 http.cpp:1115] HTTP POST for /master/api/v1 from 
172.17.0.2:33440
I0817 02:23:25.190681 18751 http.cpp:263] Processing call UNRESERVE_RESOURCES
I0817 02:23:25.191421 18751 master.cpp:3890] Authorizing principal 
'test-principal' to unreserve resources 
'[{"disk":{"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f","mount":{"root":"./csi/org.apache.mesos.csi.test/local/mounts"},"profile":"test","type":"MOUNT","vendor":"org.apache.mesos.csi.test.local"}},"name":"disk","provider_id":{"value":"a7f8a9d4-1268-4cc2-92b7-d1e217583e4a"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I0817 02:23:25.193734 18748 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O5
I0817 02:23:25.193954 18749 sched.cpp:960] Rescinded offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O5
I0817 02:23:25.194043 18749 sched.cpp:971] Scheduler::offerRescinded took 
24856ns
I0817 02:23:25.194670 18760 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048,
 allocated: {}) on agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-47
 84-b400-cfef568aba0c-0000
I0817 02:23:25.194783 18760 hierarchical.cpp:1268] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 filtered agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 for 5secs
I0817 02:23:25.197082 18757 master.cpp:12615] Sending operation '' (uuid: 
256e1b8d-fec8-4ebe-b333-1d474b3f1828) to agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:25.197623 18754 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.200453 18748 provider.cpp:481] Received APPLY_OPERATION event
I0817 02:23:25.200495 18748 provider.cpp:1295] Received UNRESERVE operation '' 
(uuid: 256e1b8d-fec8-4ebe-b333-1d474b3f1828)
I0817 02:23:25.208739 18762 hierarchical.cpp:1510] Performed allocation for 1 
agents in 1.293942ms
I0817 02:23:25.209316 18754 http.cpp:1115] HTTP POST for 
/slave(1225)/api/v1/resource_provider from 172.17.0.2:33430
I0817 02:23:25.209477 18758 master.cpp:10432] Sending offers [ 
df01c76b-8ba7-4784-b400-cfef568aba0c-O6 ] to framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.210170 18763 sched.cpp:934] Scheduler::resourceOffers took 
87165ns
I0817 02:23:25.210543 18755 slave.cpp:8423] Handling resource provider message 
'UPDATE_OPERATION_STATUS: (uuid: 86cd5132-97ed-4c0d-b404-230c7a350dc8) for 
framework  (latest state: OPERATION_FINISHED, status update state: 
OPERATION_FINISHED)'
I0817 02:23:25.210772 18755 slave.cpp:8876] Updating the state of operation 
with no ID (uuid: 86cd5132-97ed-4c0d-b404-230c7a350dc8) for an operation API 
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0817 02:23:25.210850 18755 slave.cpp:8630] Forwarding status update of 
operation with no ID (operation_uuid: 86cd5132-97ed-4c0d-b404-230c7a350dc8) for 
an operator API call
I0817 02:23:25.211225 18751 master.cpp:12271] Updating the state of operation 
'' (uuid: 86cd5132-97ed-4c0d-b404-230c7a350dc8) for an operator API call 
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0817 02:23:25.211766 18757 status_update_manager_process.hpp:152] Received 
operation status update OPERATION_FINISHED (Status UUID: 
7b25227b-7468-4426-aec8-7112352670c7) for operation UUID 
256e1b8d-fec8-4ebe-b333-1d474b3f1828 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.211793 18760 slave.cpp:4352] Ignoring new checkpointed resources 
and operations identical to the current version
I0817 02:23:25.211838 18757 status_update_manager_process.hpp:414] Creating 
operation status update stream 256e1b8d-fec8-4ebe-b333-1d474b3f1828 
checkpoint=true
I0817 02:23:25.212132 18757 status_update_manager_process.hpp:929] 
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status 
UUID: 7b25227b-7468-4426-aec8-7112352670c7) for operation UUID 
256e1b8d-fec8-4ebe-b333-1d474b3f1828 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.213119 18755 provider.cpp:481] Received 
ACKNOWLEDGE_OPERATION_STATUS event
I0817 02:23:25.228583 18757 status_update_manager_process.hpp:528] Forwarding 
operation status update OPERATION_FINISHED (Status UUID: 
7b25227b-7468-4426-aec8-7112352670c7) for operation UUID 
256e1b8d-fec8-4ebe-b333-1d474b3f1828 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.228883 18757 status_update_manager_process.hpp:252] Received 
operation status update acknowledgement (UUID: 
40c93524-59ad-476b-bf1c-485bddb761ed) for stream 
86cd5132-97ed-4c0d-b404-230c7a350dc8
I0817 02:23:25.228955 18757 status_update_manager_process.hpp:929] 
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 
40c93524-59ad-476b-bf1c-485bddb761ed) for operation UUID 
86cd5132-97ed-4c0d-b404-230c7a350dc8 on agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.229326 18761 http_connection.hpp:131] Sending 2 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.230329 18756 process.cpp:3671] Handling HTTP event for process 
'slave(1225)' with path: '/slave(1225)/api/v1/resource_provider'
I0817 02:23:25.245321 18757 status_update_manager_process.hpp:490] Cleaning up 
operation status update stream 86cd5132-97ed-4c0d-b404-230c7a350dc8
I0817 02:23:25.254613 18753 master.cpp:1412] Framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053 disconnected
I0817 02:23:25.254655 18753 master.cpp:3362] Deactivating framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.255028 18759 hierarchical.cpp:475] Deactivated framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:25.255610 18753 master.cpp:12724] Removing offer 
df01c76b-8ba7-4784-b400-cfef568aba0c-O6
I0817 02:23:25.255645 18748 slave.cpp:924] Agent terminating
I0817 02:23:25.255702 18753 master.cpp:3339] Disconnecting framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.255765 18753 master.cpp:1427] Giving framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053 0ns to failover
I0817 02:23:25.256549 18748 manager.cpp:163] Terminating resource provider 
a7f8a9d4-1268-4cc2-92b7-d1e217583e4a
I0817 02:23:25.256829 18759 hierarchical.cpp:1222] Recovered disk(allocated: 
storage/default-role)(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048;
 cpus(allocated: storage/default-role):2; mem(allocated: 
storage/default-role):1024; disk(allocated: storage/default-role):1024; 
ports(allocated: storage/default-role):[31000-32000] (total: cpus:2; mem:1024; 
disk:1024; ports:[31000-32000]; disk(reservations: 
[(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_OrWBhS/2GB-efc03650-7f13-422f-aae4-d1f12c3f262f,test)]:2048,
 allocated: {}) on agent df01c76b-8ba7-4784-b400-cfef568aba0c-S0 from framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:25.257036 18756 master.cpp:10224] Framework failover timeout, 
removing framework df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
I0817 02:23:25.257088 18756 master.cpp:11223] Removing framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000 (default) at 
[email protected]:46053
E0817 02:23:25.257552 18753 http_connection.hpp:452] End-Of-File received
I0817 02:23:25.257578 18752 hierarchical.cpp:1434] Allocation paused
I0817 02:23:25.257669 18756 master.cpp:1297] Agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f) disconnected
I0817 02:23:25.257706 18756 master.cpp:3399] Disconnecting agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:25.257825 18756 master.cpp:3418] Deactivating agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 at slave(1225)@172.17.0.2:46053 
(a1a8a771d01f)
I0817 02:23:25.258147 18752 hierarchical.cpp:417] Removed framework 
df01c76b-8ba7-4784-b400-cfef568aba0c-0000
I0817 02:23:25.258209 18752 hierarchical.cpp:1444] Allocation resumed
E0817 02:23:25.258210 18754 provider.cpp:2186] Failed to send status update for 
operation (uuid: 256e1b8d-fec8-4ebe-b333-1d474b3f1828): Disconnected
I0817 02:23:25.258214 18753 http_connection.hpp:217] Re-detecting endpoint
I0817 02:23:25.258261 18752 hierarchical.cpp:803] Agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0 deactivated
I0817 02:23:25.258673 18753 http_connection.hpp:338] Ignoring disconnection 
attempt from stale connection
I0817 02:23:25.258738 18753 http_connection.hpp:338] Ignoring disconnection 
attempt from stale connection
I0817 02:23:25.258771 18751 provider.cpp:471] Disconnected from resource 
provider manager
I0817 02:23:25.258806 18753 http_connection.hpp:227] New endpoint detected at 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.258890 18750 status_update_manager_process.hpp:379] Pausing 
operation status update manager
I0817 02:23:25.260262 18752 containerizer.cpp:2616] Destroying container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 in RUNNING state
I0817 02:23:25.260336 18752 containerizer.cpp:3319] Transitioning the state of 
container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 from RUNNING to DESTROYING after 1.144513152secs
I0817 02:23:25.260846 18752 launcher.cpp:161] Asked to destroy container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:25.262311 18754 hierarchical.cpp:1510] Performed allocation for 1 
agents in 180878ns
I0817 02:23:25.263746 18749 http_connection.hpp:283] Connected with the remote 
endpoint at http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.264380 18762 provider.cpp:459] Connected to resource provider 
manager
I0817 02:23:25.265100 18759 http_connection.hpp:131] Sending 1 call to 
http://172.17.0.2:46053/slave(1225)/api/v1/resource_provider
I0817 02:23:25.265858 18764 process.cpp:2781] Returning '404 Not Found' for 
'/slave(1225)/api/v1/resource_provider'
E0817 02:23:25.267208 18751 provider.cpp:702] Failed to subscribe resource 
provider with type 'org.apache.mesos.rp.local.storage' and name 'test': 
Received '404 Not Found' ()
I0817 02:23:25.314218 18750 hierarchical.cpp:1510] Performed allocation for 1 
agents in 201973ns
I0817 02:23:25.365175 18748 containerizer.cpp:3157] Container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
 has exited
I0817 02:23:25.365844 18763 hierarchical.cpp:1510] Performed allocation for 1 
agents in 186396ns
I0817 02:23:25.366935 18760 provisioner.cpp:612] Ignoring destroy request for 
unknown container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:25.369554 18762 container_daemon.cpp:189] Invoking post-stop hook 
for container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:25.369777 18754 service_manager.cpp:723] Disconnected from endpoint 
'unix:///tmp/mesos-csi-Dn1rF8/endpoint.sock' of CSI plugin container 
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0817 02:23:25.370024 18751 container_daemon.cpp:121] Launching container 
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0817 02:23:25.372629 18764 process.cpp:2781] Returning '404 Not Found' for 
'/slave(1225)/api/v1'
I0817 02:23:25.384846 18747 master.cpp:1137] Master terminating
I0817 02:23:25.385583 18757 hierarchical.cpp:779] Removed all filters for agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
I0817 02:23:25.385607 18757 hierarchical.cpp:654] Removed agent 
df01c76b-8ba7-4784-b400-cfef568aba0c-S0
[       OK ] 
CSIVersion/StorageLocalResourceProviderTest.OperatorOperationsWithResourceProviderResources/v1
 (1029 ms)
[----------] 50 tests from CSIVersion/StorageLocalResourceProviderTest (65668 
ms total)

[----------] Global test environment tear-down
[==========] 2301 tests from 218 test cases ran. (723140 ms total)
[  PASSED  ] 2300 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] 
CSIVersion/StorageLocalResourceProviderTest.CreateDestroyPreprovisionedVolume/v1,
 where GetParam() = "v1"

 1 FAILED TEST
  YOU HAVE 32 DISABLED TESTS

I0817 02:23:25.482730 18764 process.cpp:935] Stopped the socket accept loop
make[4]: *** [check-local] Error 1
make[4]: Leaving directory `/mesos/mesos-1.9.0/_build/src'
make[3]: *** [check-am] Error 2
make[3]: Leaving directory `/mesos/mesos-1.9.0/_build/src'
make[2]: *** [check] Error 2
make[2]: Leaving directory `/mesos/mesos-1.9.0/_build/src'
make[1]: *** [check-recursive] Error 1
make[1]: Leaving directory `/mesos/mesos-1.9.0/_build'
make: *** [distcheck] Error 1
+ docker rmi --force mesos-1566003035-7440
Untagged: mesos-1566003035-7440:latest
Deleted: sha256:33b6d73c6b3cd5f644bdbfbfb5a6e2e8ebafe4fb24ef6e305ecadd6dab9bb998
Deleted: sha256:3e27f08ebf4f727b28717ce3940cba80533c38057d1f39a80cbedf29cadf194a
Deleted: sha256:3445880698c0c781c07bc1aa8e6ff528e7c8577ebc8a39dc13218094f09596fe
Deleted: sha256:7d82f5970c98d8518384df8d0ef79ffeda258b8ea3915c4c71f58467304b90be
Deleted: sha256:c96fc6c5e645b7bd2224558417570468c984d6c122f44eaad458a5fb0e7a5f42
Deleted: sha256:7805ddb5616f6e9d1cf08c4dede2180f1f2f93205624266f1e99dc2276372a46
Deleted: sha256:2db58d4bd2edb0530c613367fdb24d7402dcbc0e13889e08e54eb7ecad123184
Deleted: sha256:397bcfd748606ceb20e1abf21d586e45f0fbed9553000763496447c858c90a85
Deleted: sha256:b07a2fba384a888ad0aca1e51cd5d47975db60986ad23ce1b2c99bb8e05cf41e
Deleted: sha256:16493c7a01af1a8456b5689aa690b1f6f473ba2448653947969c27b82ece16a3
Deleted: sha256:08f39a6a1e44e4cc872b9ef429603e84da6f83d97f006ece88cd2894fcf5f095
Deleted: sha256:71677e9817cca335da4b1f5639efb577eeef4d0039bac9a353e66b0c0c6ddab8
Deleted: sha256:4c8b919bb32121fb460ee9295c6bf0b9a71db0d1819758c4da594068a759f5e6
Deleted: sha256:4496937d057029e374c02bb340ec34a20470fb0ee0caafc41e774b40b479fc37
Deleted: sha256:86f40bf0b465673db3507a0e5fe20816f735c330e82247abdf2841fedbf88e8f
Deleted: sha256:3f01498bf32021c921abe8d03e64b72b0e0c62c4a47972ad00598ec0ac0f7815
Deleted: sha256:5f5d2ce2c758c0ba460a9014f508d49adbe2f6bdd5ccdf6e7192f26425033f07
Deleted: sha256:ff4f783fd711557b08d262d1aa5df992f346dbfe4418cd91644824096230ccb7
Deleted: sha256:93d1a03fe372d6ba513c904b68779377ef661342782bde382c7168a539fcfeb7
Deleted: sha256:ce608befde330cdd3cc02dd26d71191978f4304a6d20c507c8cfc33337174fe3
Deleted: sha256:8c6bd38be42747caa5e430949c1c008a6ba2bfd733730df8e146012aa923ee09
Deleted: sha256:8e81400cc41850c79dad7ac78f96fb4b7645d05e913fa2d37935c97c578d68d4
Deleted: sha256:d7ce9a1cc9b8903b366eb9cb8a4bcc9cc0215360766e85f75680f8fce226bfcd
Deleted: sha256:cc40eced3f33013a02a59ac628c26989782cd1d41a426458018baf52a61df3f8
Deleted: sha256:c84ed7a2b691ba96504df73c642f4c3ec819c51b0d20722d4b6e34523a27e78a
Deleted: sha256:88e9289ca99fd41dbcfaec229e4c16b9f4c4ecfdefb283ef65e51609fb6b1c55
Deleted: sha256:403ecc14458c32485f4fc0c34e465948f172ec197d6aa588a1f62f5bfb1823f2
Deleted: sha256:f16ee6bef02d85104a120766cb98c55c3a453eea80147c4d4e233a3b8ea17e0e
Deleted: sha256:ba731e3324b1b436488016785febaa811939e3b7fd6931b33352fe49c17d7f53
Deleted: sha256:8b87f880d32af4bfe567fea7e1cd2eae738186dcafcc76bf7acc22b6305cdf1b

Full log: https://builds.apache.org/job/Mesos-Reviewbot-Linux/3184/console

- Mesos Reviewbot


On Aug. 16, 2019, 4:09 p.m., Benjamin Mahler wrote:
> 
> -----------------------------------------------------------
> This is an automatically generated e-mail. To reply, visit:
> https://reviews.apache.org/r/71302/
> -----------------------------------------------------------
> 
> (Updated Aug. 16, 2019, 4:09 p.m.)
> 
> 
> Review request for mesos, Andrei Sekretenko and Meng Zhu.
> 
> 
> Bugs: MESOS-9669
>     https://issues.apache.org/jira/browse/MESOS-9669
> 
> 
> Repository: mesos
> 
> 
> Description
> -------
> 
> This endpoint is already hidden from the quota documentation,
> this updates the endpoint to note the deprecation.
> 
> 
> Diffs
> -----
> 
>   src/master/http.cpp 684a0f73f9a598fbc44e64b9a66aadbf91b7e7e6 
>   src/master/master.hpp 783e4a38ad9e36cb38d5e78b6b942033bc806a0a 
>   src/master/master.cpp 599f62d1affe0961bdf01b41c009563b008b8a2a 
> 
> 
> Diff: https://reviews.apache.org/r/71302/diff/1/
> 
> 
> Testing
> -------
> 
> make check
> 
> 
> Thanks,
> 
> Benjamin Mahler
> 
>

Re: Review Request 71302: Marked /quota endpoint as deprecated.

Reply via email to