----------------------------------------------------------- This is an automatically generated e-mail. To reply, visit: https://reviews.apache.org/r/71441/#review217605 -----------------------------------------------------------
Bad patch! Reviews applied: [71441] 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_71441"] Error: ...<truncated>... 9:24:09.606482 18639 hierarchical.cpp:1726] Performed allocation for 1 agents in 987973ns I0906 09:24:09.606830 18639 hierarchical.cpp:1726] Performed allocation for 1 agents in 182810ns I0906 09:24:09.607092 18638 master.cpp:10432] Sending offers [ 7fc159b6-c052-42d9-b381-854540f8c3e1-O4 ] to framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 I0906 09:24:09.607820 18627 sched.cpp:934] Scheduler::resourceOffers took 85724ns I0906 09:24:09.616456 18635 http.cpp:1115] HTTP POST for /slave(1246)/api/v1/resource_provider from 172.17.0.3:58998 I0906 09:24:09.617684 18631 slave.cpp:8481] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 5eb6008c-dc46-4734-84e3-ccf1735ee327) for framework (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)' I0906 09:24:09.617880 18631 slave.cpp:8934] Updating the state of operation with no ID (uuid: 5eb6008c-dc46-4734-84e3-ccf1735ee327) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED) I0906 09:24:09.617925 18631 slave.cpp:8688] Forwarding status update of operation with no ID (operation_uuid: 5eb6008c-dc46-4734-84e3-ccf1735ee327) for an operator API call I0906 09:24:09.618274 18622 master.cpp:12271] Updating the state of operation '' (uuid: 5eb6008c-dc46-4734-84e3-ccf1735ee327) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED) I0906 09:24:09.618831 18634 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version I0906 09:24:09.718955 18627 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: 3921e652-54f4-4e59-b058-a26fc5622ace) for operation UUID 13b0617f-06ad-427b-8d90-803d7271dfc9 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:09.719056 18627 status_update_manager_process.hpp:414] Creating operation status update stream 13b0617f-06ad-427b-8d90-803d7271dfc9 checkpoint=true I0906 09:24:09.719115 18637 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event I0906 09:24:09.719399 18627 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: 3921e652-54f4-4e59-b058-a26fc5622ace) for operation UUID 13b0617f-06ad-427b-8d90-803d7271dfc9 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:09.810786 18627 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: 3921e652-54f4-4e59-b058-a26fc5622ace) for operation UUID 13b0617f-06ad-427b-8d90-803d7271dfc9 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:09.811287 18627 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: ee7d1ff5-502a-49b4-91e9-a532d5279ee0) for stream 5eb6008c-dc46-4734-84e3-ccf1735ee327 I0906 09:24:09.811357 18627 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: ee7d1ff5-502a-49b4-91e9-a532d5279ee0) for operation UUID 5eb6008c-dc46-4734-84e3-ccf1735ee327 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:09.811977 18626 http_connection.hpp:131] Sending UPDATE_OPERATION_STATUS call to http://172.17.0.3:36221/slave(1246)/api/v1/resource_provider I0906 09:24:09.813196 18628 process.cpp:3671] Handling HTTP event for process 'slave(1246)' with path: '/slave(1246)/api/v1/resource_provider' I0906 09:24:09.852684 18634 http.cpp:1115] HTTP POST for /slave(1246)/api/v1/resource_provider from 172.17.0.3:58998 I0906 09:24:09.853847 18625 slave.cpp:8481] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 13b0617f-06ad-427b-8d90-803d7271dfc9) for framework (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)' I0906 09:24:09.854044 18625 slave.cpp:8934] Updating the state of operation with no ID (uuid: 13b0617f-06ad-427b-8d90-803d7271dfc9) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED) I0906 09:24:09.854100 18625 slave.cpp:8688] Forwarding status update of operation with no ID (operation_uuid: 13b0617f-06ad-427b-8d90-803d7271dfc9) for an operator API call I0906 09:24:09.854467 18624 master.cpp:12271] Updating the state of operation '' (uuid: 13b0617f-06ad-427b-8d90-803d7271dfc9) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED) I0906 09:24:09.854990 18632 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version I0906 09:24:09.856642 18640 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event I0906 09:24:09.894429 18627 status_update_manager_process.hpp:490] Cleaning up operation status update stream 5eb6008c-dc46-4734-84e3-ccf1735ee327 I0906 09:24:09.894783 18627 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: 3921e652-54f4-4e59-b058-a26fc5622ace) for stream 13b0617f-06ad-427b-8d90-803d7271dfc9 I0906 09:24:09.894901 18627 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 3921e652-54f4-4e59-b058-a26fc5622ace) for operation UUID 13b0617f-06ad-427b-8d90-803d7271dfc9 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:09.986759 18627 status_update_manager_process.hpp:490] Cleaning up operation status update stream 13b0617f-06ad-427b-8d90-803d7271dfc9 I0906 09:24:10.050118 18622 process.cpp:3671] Handling HTTP event for process 'master' with path: '/master/api/v1' I0906 09:24:10.051868 18620 http.cpp:1115] HTTP POST for /master/api/v1 from 172.17.0.3:59006 I0906 09:24:10.052096 18620 http.cpp:263] Processing call DESTROY_VOLUMES I0906 09:24:10.052856 18620 master.cpp:3998] Authorizing principal 'test-principal' to destroy volumes '[{"disk":{"persistence":{"id":"b6fe4eec-d836-4290-8783-e7bce5219551","principal":"test-principal"},"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b","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":"863433f8-2780-4e92-a5c4-ecdc9fb8cbcf"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]' I0906 09:24:10.054839 18619 master.cpp:12724] Removing offer 7fc159b6-c052-42d9-b381-854540f8c3e1-O4 I0906 09:24:10.054980 18638 sched.cpp:960] Rescinded offer 7fc159b6-c052-42d9-b381-854540f8c3e1-O4 I0906 09:24:10.055063 18638 sched.cpp:971] Scheduler::offerRescinded took 25628ns I0906 09:24:10.055990 18639 hierarchical.cpp:1451] Recovered ports(allocated: storage/default-role):[31000-32000]; 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_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b,test),b6fe4eec-d836-4290-8783-e7bce5219551:volume]:2048; 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),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b,test),b6fe4eec-d836-4290-8783-e7bce5219551:volume]:2048, offered or allocated: {}) on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 from framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 I0906 09:24:10.056130 18639 hierarchical.cpp:1498] Framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 filtered agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 for 5secs I0906 09:24:10.058708 18642 master.cpp:12615] Sending operation '' (uuid: 41791032-3abc-4b3f-8a5d-739e9aa28712) to agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 at slave(1246)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.059216 18628 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version I0906 09:24:10.061848 18625 provider.cpp:498] Received APPLY_OPERATION event I0906 09:24:10.061883 18625 provider.cpp:1351] Received DESTROY operation '' (uuid: 41791032-3abc-4b3f-8a5d-739e9aa28712) I0906 09:24:10.070102 18624 hierarchical.cpp:1726] Performed allocation for 1 agents in 1.000047ms I0906 09:24:10.070639 18623 master.cpp:10432] Sending offers [ 7fc159b6-c052-42d9-b381-854540f8c3e1-O5 ] to framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 I0906 09:24:10.071213 18620 sched.cpp:934] Scheduler::resourceOffers took 74324ns I0906 09:24:10.156101 18641 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: 804c5e41-b5f4-48e6-a947-1efef909ffae) for operation UUID 41791032-3abc-4b3f-8a5d-739e9aa28712 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.156160 18641 status_update_manager_process.hpp:414] Creating operation status update stream 41791032-3abc-4b3f-8a5d-739e9aa28712 checkpoint=true I0906 09:24:10.156442 18641 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: 804c5e41-b5f4-48e6-a947-1efef909ffae) for operation UUID 41791032-3abc-4b3f-8a5d-739e9aa28712 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.206327 18641 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: 804c5e41-b5f4-48e6-a947-1efef909ffae) for operation UUID 41791032-3abc-4b3f-8a5d-739e9aa28712 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.207244 18638 http_connection.hpp:131] Sending UPDATE_OPERATION_STATUS call to http://172.17.0.3:36221/slave(1246)/api/v1/resource_provider I0906 09:24:10.208616 18626 process.cpp:3671] Handling HTTP event for process 'slave(1246)' with path: '/slave(1246)/api/v1/resource_provider' I0906 09:24:10.211926 18640 process.cpp:3671] Handling HTTP event for process 'master' with path: '/master/api/v1' I0906 09:24:10.213547 18622 http.cpp:1115] HTTP POST for /master/api/v1 from 172.17.0.3:59008 I0906 09:24:10.213819 18622 http.cpp:263] Processing call UNRESERVE_RESOURCES I0906 09:24:10.214483 18622 master.cpp:3890] Authorizing principal 'test-principal' to unreserve resources '[{"disk":{"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b","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":"863433f8-2780-4e92-a5c4-ecdc9fb8cbcf"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]' I0906 09:24:10.216207 18633 master.cpp:12724] Removing offer 7fc159b6-c052-42d9-b381-854540f8c3e1-O5 I0906 09:24:10.216302 18623 sched.cpp:960] Rescinded offer 7fc159b6-c052-42d9-b381-854540f8c3e1-O5 I0906 09:24:10.216372 18623 sched.cpp:971] Scheduler::offerRescinded took 20811ns I0906 09:24:10.217164 18624 hierarchical.cpp:1451] Recovered ports(allocated: storage/default-role):[31000-32000]; 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_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b,test)]:2048; 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),(DYNAMIC,storage/default-role,test-principal)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b,test)]:2048, offered or allocated: {}) on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 from framework 7fc15 9b6-c052-42d9-b381-854540f8c3e1-0000 I0906 09:24:10.217259 18624 hierarchical.cpp:1498] Framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 filtered agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 for 5secs I0906 09:24:10.219244 18620 master.cpp:12615] Sending operation '' (uuid: c3d3e015-2387-4867-b5a9-81b5cc376088) to agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 at slave(1246)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.219704 18632 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version I0906 09:24:10.222112 18637 hierarchical.cpp:1726] Performed allocation for 1 agents in 1.111959ms I0906 09:24:10.222447 18634 provider.cpp:498] Received APPLY_OPERATION event I0906 09:24:10.222496 18634 provider.cpp:1351] Received UNRESERVE operation '' (uuid: c3d3e015-2387-4867-b5a9-81b5cc376088) I0906 09:24:10.222944 18631 master.cpp:10432] Sending offers [ 7fc159b6-c052-42d9-b381-854540f8c3e1-O6 ] to framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 I0906 09:24:10.223560 18635 sched.cpp:934] Scheduler::resourceOffers took 80818ns I0906 09:24:10.248602 18625 http.cpp:1115] HTTP POST for /slave(1246)/api/v1/resource_provider from 172.17.0.3:58998 I0906 09:24:10.249531 18639 slave.cpp:8481] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 41791032-3abc-4b3f-8a5d-739e9aa28712) for framework (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)' I0906 09:24:10.249717 18639 slave.cpp:8934] Updating the state of operation with no ID (uuid: 41791032-3abc-4b3f-8a5d-739e9aa28712) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED) I0906 09:24:10.249763 18639 slave.cpp:8688] Forwarding status update of operation with no ID (operation_uuid: 41791032-3abc-4b3f-8a5d-739e9aa28712) for an operator API call I0906 09:24:10.250062 18632 master.cpp:12271] Updating the state of operation '' (uuid: 41791032-3abc-4b3f-8a5d-739e9aa28712) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED) I0906 09:24:10.250828 18642 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version I0906 09:24:10.316509 18635 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: 1148e9ee-13c4-4639-8e05-b3ae3fbb304b) for operation UUID c3d3e015-2387-4867-b5a9-81b5cc376088 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.316583 18634 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event I0906 09:24:10.316622 18635 status_update_manager_process.hpp:414] Creating operation status update stream c3d3e015-2387-4867-b5a9-81b5cc376088 checkpoint=true I0906 09:24:10.317005 18635 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: 1148e9ee-13c4-4639-8e05-b3ae3fbb304b) for operation UUID c3d3e015-2387-4867-b5a9-81b5cc376088 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.366827 18635 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: 1148e9ee-13c4-4639-8e05-b3ae3fbb304b) for operation UUID c3d3e015-2387-4867-b5a9-81b5cc376088 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.367332 18635 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: 804c5e41-b5f4-48e6-a947-1efef909ffae) for stream 41791032-3abc-4b3f-8a5d-739e9aa28712 I0906 09:24:10.367415 18635 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 804c5e41-b5f4-48e6-a947-1efef909ffae) for operation UUID 41791032-3abc-4b3f-8a5d-739e9aa28712 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.367903 18623 http_connection.hpp:131] Sending UPDATE_OPERATION_STATUS call to http://172.17.0.3:36221/slave(1246)/api/v1/resource_provider I0906 09:24:10.369055 18624 process.cpp:3671] Handling HTTP event for process 'slave(1246)' with path: '/slave(1246)/api/v1/resource_provider' I0906 09:24:10.408294 18636 http.cpp:1115] HTTP POST for /slave(1246)/api/v1/resource_provider from 172.17.0.3:58998 I0906 09:24:10.409597 18642 slave.cpp:8481] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: c3d3e015-2387-4867-b5a9-81b5cc376088) for framework (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)' I0906 09:24:10.409822 18642 slave.cpp:8934] Updating the state of operation with no ID (uuid: c3d3e015-2387-4867-b5a9-81b5cc376088) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED) I0906 09:24:10.409883 18642 slave.cpp:8688] Forwarding status update of operation with no ID (operation_uuid: c3d3e015-2387-4867-b5a9-81b5cc376088) for an operator API call I0906 09:24:10.410259 18640 master.cpp:12271] Updating the state of operation '' (uuid: c3d3e015-2387-4867-b5a9-81b5cc376088) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED) I0906 09:24:10.410859 18627 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version I0906 09:24:10.412482 18633 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event I0906 09:24:10.433670 18635 status_update_manager_process.hpp:490] Cleaning up operation status update stream 41791032-3abc-4b3f-8a5d-739e9aa28712 I0906 09:24:10.433975 18635 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: 1148e9ee-13c4-4639-8e05-b3ae3fbb304b) for stream c3d3e015-2387-4867-b5a9-81b5cc376088 I0906 09:24:10.434062 18635 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 1148e9ee-13c4-4639-8e05-b3ae3fbb304b) for operation UUID c3d3e015-2387-4867-b5a9-81b5cc376088 on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.500864 18635 status_update_manager_process.hpp:490] Cleaning up operation status update stream c3d3e015-2387-4867-b5a9-81b5cc376088 I0906 09:24:10.602960 18641 master.cpp:1412] Framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 disconnected I0906 09:24:10.603003 18641 master.cpp:3362] Deactivating framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 I0906 09:24:10.603343 18636 hierarchical.cpp:711] Deactivated framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 I0906 09:24:10.603814 18641 master.cpp:12724] Removing offer 7fc159b6-c052-42d9-b381-854540f8c3e1-O6 I0906 09:24:10.603888 18641 master.cpp:3339] Disconnecting framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 I0906 09:24:10.603935 18641 master.cpp:1427] Giving framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 0ns to failover I0906 09:24:10.604001 18627 slave.cpp:924] Agent terminating I0906 09:24:10.604499 18636 hierarchical.cpp:1451] Recovered ports(allocated: storage/default-role):[31000-32000]; disk(allocated: storage/default-role)(reservations: [(DYNAMIC,storage)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b,test)]:2048; 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)])[MOUNT(org.apache.mesos.csi.test.local,/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_6M21vI/2GB-9c41db5a-cc7b-4389-a0eb-b902e2fdce6b,test)]:2048, offered or allocated: {}) on agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 from framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 I0906 09:24:10.604806 18627 manager.cpp:163] Terminating resource provider 863433f8-2780-4e92-a5c4-ecdc9fb8cbcf I0906 09:24:10.605269 18638 master.cpp:1297] Agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 at slave(1246)@172.17.0.3:36221 (e22630eaba3d) disconnected I0906 09:24:10.605300 18638 master.cpp:3399] Disconnecting agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 at slave(1246)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.605391 18638 master.cpp:3418] Deactivating agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 at slave(1246)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.605513 18630 hierarchical.cpp:1038] Agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 deactivated I0906 09:24:10.605621 18638 master.cpp:10224] Framework failover timeout, removing framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 I0906 09:24:10.605653 18638 master.cpp:11223] Removing framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 (default) at scheduler-3cd6d54a-616a-4497-a48b-77109beb52c6@172.17.0.3:36221 E0906 09:24:10.605845 18637 http_connection.hpp:452] End-Of-File received I0906 09:24:10.605988 18621 hierarchical.cpp:1650] Allocation paused I0906 09:24:10.606276 18637 http_connection.hpp:217] Re-detecting endpoint I0906 09:24:10.606468 18621 hierarchical.cpp:655] Removed framework 7fc159b6-c052-42d9-b381-854540f8c3e1-0000 I0906 09:24:10.606549 18621 hierarchical.cpp:1660] Allocation resumed I0906 09:24:10.606670 18637 http_connection.hpp:338] Ignoring disconnection attempt from stale connection I0906 09:24:10.606734 18637 http_connection.hpp:338] Ignoring disconnection attempt from stale connection I0906 09:24:10.606806 18620 provider.cpp:488] Disconnected from resource provider manager I0906 09:24:10.606854 18637 http_connection.hpp:227] New endpoint detected at http://172.17.0.3:36221/slave(1246)/api/v1/resource_provider I0906 09:24:10.606915 18620 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:10.608306 18619 containerizer.cpp:2620] Destroying container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE in RUNNING state I0906 09:24:10.608355 18619 containerizer.cpp:3323] 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 3.34677184secs I0906 09:24:10.608741 18619 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:10.610190 18638 hierarchical.cpp:1726] Performed allocation for 1 agents in 149535ns I0906 09:24:10.610190 18640 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.3:36221/slave(1246)/api/v1/resource_provider I0906 09:24:10.610667 18620 provider.cpp:476] Connected to resource provider manager I0906 09:24:10.611311 18633 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.3:36221/slave(1246)/api/v1/resource_provider I0906 09:24:10.612041 18643 process.cpp:2781] Returning '404 Not Found' for '/slave(1246)/api/v1/resource_provider' E0906 09:24:10.613174 18637 provider.cpp:721] Failed to subscribe resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test': Received '404 Not Found' () I0906 09:24:10.661381 18632 hierarchical.cpp:1726] Performed allocation for 1 agents in 199297ns I0906 09:24:10.711388 18631 containerizer.cpp:3161] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE has exited I0906 09:24:10.712849 18636 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 I0906 09:24:10.712915 18623 hierarchical.cpp:1726] Performed allocation for 1 agents in 166463ns I0906 09:24:10.715298 18642 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' I0906 09:24:10.715467 18626 service_manager.cpp:723] Disconnected from endpoint 'unix:///tmp/mesos-csi-L50wnO/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:10.715668 18629 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:10.718439 18643 process.cpp:2781] Returning '404 Not Found' for '/slave(1246)/api/v1' I0906 09:24:10.727231 18634 master.cpp:1137] Master terminating I0906 09:24:10.727963 18621 hierarchical.cpp:1014] Removed all filters for agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 I0906 09:24:10.727988 18621 hierarchical.cpp:891] Removed agent 7fc159b6-c052-42d9-b381-854540f8c3e1-S0 [ OK ] CSIVersion/StorageLocalResourceProviderTest.OperatorOperationsWithResourceProviderResources/v1 (3226 ms) [ RUN ] CSIVersion/StorageLocalResourceProviderTest.Update/v0 I0906 09:24:10.745229 18618 cluster.cpp:177] Creating default 'local' authorizer I0906 09:24:10.749688 18628 master.cpp:440] Master 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8 (e22630eaba3d) started on 172.17.0.3:36221 I0906 09:24:10.749714 18628 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/ltg25U/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.10.0/_inst/share/mesos/webui" --work_dir="/tmp/ltg25U/master" --zk_session_timeout="10secs" I0906 09:24:10.750124 18628 master.cpp:492] Master only allowing authenticated frameworks to register I0906 09:24:10.750145 18628 master.cpp:498] Master only allowing authenticated agents to register I0906 09:24:10.750160 18628 master.cpp:504] Master only allowing authenticated HTTP frameworks to register I0906 09:24:10.750174 18628 credentials.hpp:37] Loading credentials for authentication from '/tmp/ltg25U/credentials' I0906 09:24:10.750496 18628 master.cpp:548] Using default 'crammd5' authenticator I0906 09:24:10.750732 18628 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0906 09:24:10.751013 18628 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0906 09:24:10.751202 18628 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0906 09:24:10.751376 18628 master.cpp:629] Authorization enabled I0906 09:24:10.751777 18627 whitelist_watcher.cpp:77] No whitelist given I0906 09:24:10.751783 18626 hierarchical.cpp:474] Initialized hierarchical allocator process I0906 09:24:10.754923 18636 master.cpp:2170] Elected as the leading master! I0906 09:24:10.754961 18636 master.cpp:1666] Recovering from registrar I0906 09:24:10.755146 18623 registrar.cpp:339] Recovering registrar I0906 09:24:10.755975 18623 registrar.cpp:383] Successfully fetched the registry (0B) in 0ns I0906 09:24:10.756119 18623 registrar.cpp:487] Applied 1 operations in 46800ns; attempting to update the registry I0906 09:24:10.756788 18623 registrar.cpp:544] Successfully updated the registry in 0ns I0906 09:24:10.756920 18623 registrar.cpp:416] Successfully recovered registrar I0906 09:24:10.757341 18622 master.cpp:1819] Recovered 0 agents from the registry (144B); allowing 10mins for agents to reregister I0906 09:24:10.757380 18624 hierarchical.cpp:513] Skipping recovery of hierarchical allocator: nothing to recover W0906 09:24:10.762900 18618 process.cpp:2877] Attempted to spawn already running process files@172.17.0.3:36221 I0906 09:24:10.764161 18618 containerizer.cpp:318] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } W0906 09:24:10.764705 18618 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges W0906 09:24:10.764731 18618 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0906 09:24:10.764863 18618 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0906 09:24:10.764899 18618 provisioner.cpp:300] Using default backend 'copy' I0906 09:24:10.767262 18618 cluster.cpp:518] Creating default 'local' authorizer I0906 09:24:10.769598 18631 slave.cpp:267] Mesos agent started on (1247)@172.17.0.3:36221 I0906 09:24:10.769624 18631 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/ltg25U/VcTed1/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/ltg25U/VcTed1/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/ltg25U/VcTed1/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/ltg25U/VcTed1/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/ltg25U/VcTed1/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/ltg25U/VcTed1/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.10.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/ltg25U/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_Update_v0_oeCJaK" --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_StorageLocalResourceProviderTest_Update_v0_4b1e8s" --zk_sessio n_timeout="10secs" I0906 09:24:10.770021 18631 credentials.hpp:86] Loading credential for authentication from '/tmp/ltg25U/VcTed1/credential' I0906 09:24:10.770210 18631 slave.cpp:300] Agent using credential for: test-principal I0906 09:24:10.770239 18631 credentials.hpp:37] Loading credentials for authentication from '/tmp/ltg25U/VcTed1/http_credentials' I0906 09:24:10.770473 18631 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0906 09:24:10.770948 18631 disk_profile_adaptor.cpp:82] Creating disk profile adaptor module 'org_apache_mesos_UriDiskProfileAdaptor' I0906 09:24:10.772609 18626 uri_disk_profile_adaptor.cpp:305] Updated disk profile mapping to 1 active profiles I0906 09:24:10.773169 18631 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"}] I0906 09:24:10.773365 18631 slave.cpp:623] Agent attributes: [ ] I0906 09:24:10.773378 18631 slave.cpp:632] Agent hostname: e22630eaba3d I0906 09:24:10.773535 18628 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:10.773541 18633 task_status_update_manager.cpp:181] Pausing sending task status updates I0906 09:24:10.775099 18619 state.cpp:67] Recovering state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_4b1e8s/meta' I0906 09:24:10.775346 18638 slave.cpp:7491] Finished recovering checkpointed state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_4b1e8s/meta', beginning agent recovery I0906 09:24:10.775995 18625 task_status_update_manager.cpp:207] Recovering task status update manager I0906 09:24:10.776404 18632 containerizer.cpp:821] Recovering Mesos containers I0906 09:24:10.776808 18632 containerizer.cpp:1161] Recovering isolators I0906 09:24:10.777770 18620 containerizer.cpp:1200] Recovering provisioner I0906 09:24:10.778482 18633 provisioner.cpp:500] Provisioner recovery complete I0906 09:24:10.779281 18635 composing.cpp:339] Finished recovering all containerizers I0906 09:24:10.779582 18629 slave.cpp:7972] Recovering executors I0906 09:24:10.779691 18629 slave.cpp:8125] Finished recovery I0906 09:24:10.780500 18622 task_status_update_manager.cpp:181] Pausing sending task status updates I0906 09:24:10.780527 18630 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:10.780551 18629 slave.cpp:1351] New master detected at master@172.17.0.3:36221 I0906 09:24:10.780728 18629 slave.cpp:1416] Detecting new master I0906 09:24:10.782042 18639 slave.cpp:1443] Authenticating with master master@172.17.0.3:36221 I0906 09:24:10.782155 18639 slave.cpp:1452] Using default CRAM-MD5 authenticatee I0906 09:24:10.782491 18624 authenticatee.cpp:121] Creating new client SASL connection I0906 09:24:10.782861 18627 master.cpp:10617] Authenticating slave(1247)@172.17.0.3:36221 I0906 09:24:10.782999 18626 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(2105)@172.17.0.3:36221 I0906 09:24:10.783319 18620 authenticator.cpp:98] Creating new server SASL connection I0906 09:24:10.783612 18628 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0906 09:24:10.783654 18628 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0906 09:24:10.783816 18636 authenticator.cpp:204] Received SASL authentication start I0906 09:24:10.783891 18636 authenticator.cpp:326] Authentication requires more steps I0906 09:24:10.784034 18633 authenticatee.cpp:259] Received SASL authentication step I0906 09:24:10.784179 18631 authenticator.cpp:232] Received SASL authentication step I0906 09:24:10.784220 18631 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e22630eaba3d' server FQDN: 'e22630eaba3d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0906 09:24:10.784235 18631 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0906 09:24:10.784281 18631 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0906 09:24:10.784305 18631 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e22630eaba3d' server FQDN: 'e22630eaba3d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0906 09:24:10.784322 18631 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0906 09:24:10.784341 18631 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0906 09:24:10.784368 18631 authenticator.cpp:318] Authentication success I0906 09:24:10.784489 18638 authenticatee.cpp:299] Authentication success I0906 09:24:10.784590 18634 master.cpp:10649] Successfully authenticated principal 'test-principal' at slave(1247)@172.17.0.3:36221 I0906 09:24:10.784629 18625 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(2105)@172.17.0.3:36221 I0906 09:24:10.784893 18621 slave.cpp:1543] Successfully authenticated with master master@172.17.0.3:36221 I0906 09:24:10.785305 18621 slave.cpp:1993] Will retry registration in 6.845497ms if necessary I0906 09:24:10.785487 18637 master.cpp:7088] Received register agent message from slave(1247)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.785760 18637 master.cpp:4204] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal' I0906 09:24:10.786420 18629 master.cpp:7155] Authorized registration of agent at slave(1247)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.786515 18629 master.cpp:7267] Registering agent at slave(1247)@172.17.0.3:36221 (e22630eaba3d) with id 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 I0906 09:24:10.787142 18632 registrar.cpp:487] Applied 1 operations in 185319ns; attempting to update the registry I0906 09:24:10.787851 18632 registrar.cpp:544] Successfully updated the registry in 0ns I0906 09:24:10.788018 18620 master.cpp:7315] Admitted agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 at slave(1247)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:10.788763 18620 master.cpp:7360] Registered agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 at slave(1247)@172.17.0.3:36221 (e22630eaba3d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0906 09:24:10.788863 18636 slave.cpp:1576] Registered with master master@172.17.0.3:36221; given agent ID 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 I0906 09:24:10.788916 18633 hierarchical.cpp:854] Added agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 (e22630eaba3d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (offered or allocated: {}) I0906 09:24:10.788978 18634 task_status_update_manager.cpp:188] Resuming sending task status updates I0906 09:24:10.789247 18633 hierarchical.cpp:1726] Performed allocation for 1 agents in 154308ns I0906 09:24:10.789356 18636 slave.cpp:1611] Checkpointing SlaveInfo to '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_4b1e8s/meta/slaves/27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0/slave.info' I0906 09:24:10.789460 18619 status_update_manager_process.hpp:385] Resuming operation status update manager I0906 09:24:10.790496 18636 slave.cpp:1663] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"uY0EcqQLQLeg5bYmneru1w=="},"slave_id":{"value":"27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0"},"update_oversubscribed_resources":false} I0906 09:24:10.791290 18625 master.cpp:8487] Ignoring update on agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 at slave(1247)@172.17.0.3:36221 (e22630eaba3d) as it reports no changes I0906 09:24:10.795374 18632 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1' I0906 09:24:10.796504 18619 http.cpp:1115] HTTP POST for /slave(1247)/api/v1 from 172.17.0.3:59016 I0906 09:24:10.797000 18619 http.cpp:2146] Processing GET_CONTAINERS call I0906 09:24:10.802088 18627 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:10.804278 18631 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1' I0906 09:24:10.805128 18623 http.cpp:1115] HTTP POST for /slave(1247)/api/v1 from 172.17.0.3:59018 I0906 09:24:10.805821 18623 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' I0906 09:24:10.806607 18637 http.cpp:2710] Creating sandbox '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_4b1e8s/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:10.807209 18640 containerizer.cpp:1396] Starting container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:10.807731 18640 containerizer.cpp:3323] 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 I0906 09:24:10.808336 18640 containerizer.cpp:1574] Checkpointed ContainerConfig at '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_oeCJaK/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config' I0906 09:24:10.808380 18640 containerizer.cpp:3323] 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 I0906 09:24:10.810904 18626 containerizer.cpp:2100] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["/mesos/mesos-1.10.0/_build/src/test-csi-plugin","--api_version=v0","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_ffzL5b","--available_capacity=0B","--volumes=","--forward=unix:///tmp/ltg25U/mock_csi.sock","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.10.0/_build/src/test-csi-plugin"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_4b1e8s/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-rkxOF7/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_4b1e8s/containers/org-apache-mesos-rp-local -storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}" --pipe_read="94" --pipe_write="95" --runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_oeCJaK/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE" --unshare_namespace_mnt="false"' I0906 09:24:10.818790 18626 launcher.cpp:145] Forked child with pid '32862' for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:10.819705 18626 containerizer.cpp:3323] 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 I0906 09:24:10.821317 18626 containerizer.cpp:3323] 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 I0906 09:24:10.821712 18636 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_Update_v0_4b1e8s/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:10.822862 18622 containerizer.cpp:3323] 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 I0906 09:24:10.825469 18630 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' I0906 09:24:10.825763 18640 service_manager.cpp:703] Connecting to endpoint 'unix:///tmp/mesos-csi-rkxOF7/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:10.977488 18621 hierarchical.cpp:1726] Performed allocation for 1 agents in 213887ns I0906 09:24:11.028652 18641 hierarchical.cpp:1726] Performed allocation for 1 agents in 212305ns I0906 09:24:11.080271 18629 hierarchical.cpp:1726] Performed allocation for 1 agents in 218084ns I0906 09:24:11.132438 18632 hierarchical.cpp:1726] Performed allocation for 1 agents in 254331ns I0906 09:24:11.184176 18621 hierarchical.cpp:1726] Performed allocation for 1 agents in 236911ns I0906 09:24:11.188431 18623 service_manager.cpp:545] Probing endpoint 'unix:///tmp/mesos-csi-rkxOF7/endpoint.sock' with CSI v1 I0906 09:24:11.191244 18625 service_manager.cpp:532] Probing endpoint 'unix:///tmp/mesos-csi-rkxOF7/endpoint.sock' with CSI v0 I0906 09:24:11.192643 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/Probe call I0906 09:24:11.195510 18642 container_daemon.cpp:171] Waiting for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:11.198730 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/GetPluginCapabilities call I0906 09:24:11.200404 18640 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1' I0906 09:24:11.202845 18621 http.cpp:1115] HTTP POST for /slave(1247)/api/v1 from 172.17.0.3:59020 I0906 09:24:11.203490 18621 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' I0906 09:24:11.205240 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/GetPluginInfo call I0906 09:24:11.206188 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/GetPluginInfo call I0906 09:24:11.208056 18642 v0_volume_manager.cpp:628] NODE_SERVICE loaded: {} I0906 09:24:11.208827 18642 v0_volume_manager.cpp:628] CONTROLLER_SERVICE loaded: {} I0906 09:24:11.211220 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ControllerGetCapabilities call I0906 09:24:11.215759 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Node/NodeGetCapabilities call I0906 09:24:11.220238 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Node/NodeGetId call I0906 09:24:11.222811 18623 provider.cpp:676] Recovered resources '{}' and 0 operations for resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test' I0906 09:24:11.222973 18641 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:11.223686 18630 http_connection.hpp:227] New endpoint detected at http://172.17.0.3:36221/slave(1247)/api/v1/resource_provider I0906 09:24:11.228125 18624 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.3:36221/slave(1247)/api/v1/resource_provider I0906 09:24:11.228858 18633 provider.cpp:476] Connected to resource provider manager I0906 09:24:11.229673 18631 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.3:36221/slave(1247)/api/v1/resource_provider I0906 09:24:11.231123 18621 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1/resource_provider' I0906 09:24:11.233081 18622 http.cpp:1115] HTTP POST for /slave(1247)/api/v1/resource_provider from 172.17.0.3:59024 I0906 09:24:11.234061 18622 manager.cpp:813] Subscribing resource provider {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.10.0/_build/src/test-csi-plugin","--api_version=v0","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_ffzL5b","--available_capacity=0B","--volumes=","--forward=unix:///tmp/ltg25U/mock_csi.sock","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.10.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"},"reconciliation_interval_seconds":15.0},"type":"org.apache.mesos.rp.local.storage"} I0906 09:24:11.235638 18623 hierarchical.cpp:1726] Performed allocation for 1 agents in 235981ns I0906 09:24:11.265972 18640 slave.cpp:8481] Handling resource provider message 'SUBSCRIBE: {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"2dfc3af3-5cd6-46bf-917c-a1dd58893cd4"},"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.10.0/_build/src/test-csi-plugin","--api_version=v0","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_ffzL5b","--available_capacity=0B","--volumes=","--forward=unix:///tmp/ltg25U/mock_csi.sock","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.10.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"},"reconciliation_interval_seconds":15.0},"type":"org.apache.mesos.rp.local.storage"}' I0906 09:24:11.268019 18638 provider.cpp:498] Received SUBSCRIBED event I0906 09:24:11.268071 18638 provider.cpp:1309] Subscribed with ID 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 I0906 09:24:11.269282 18638 status_update_manager_process.hpp:314] Recovering operation status update manager I0906 09:24:11.287287 18630 hierarchical.cpp:1726] Performed allocation for 1 agents in 273184ns I0906 09:24:11.324509 18641 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:11.327423 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call I0906 09:24:11.330484 18628 provider.cpp:2217] Sending UPDATE_STATE call with resources '{}' and 0 operations to agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 I0906 09:24:11.330827 18619 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.3:36221/slave(1247)/api/v1/resource_provider I0906 09:24:11.330898 18628 provider.cpp:748] Resource provider 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 is in READY state I0906 09:24:11.330950 18640 status_update_manager_process.hpp:385] Resuming operation status update manager I0906 09:24:11.331671 18631 provider.cpp:1235] Updating profiles { test } for resource provider 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 I0906 09:24:11.333135 18642 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:11.333168 18622 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1/resource_provider' I0906 09:24:11.335628 18619 http.cpp:1115] HTTP POST for /slave(1247)/api/v1/resource_provider from 172.17.0.3:59022 I0906 09:24:11.336174 18628 manager.cpp:1045] Received UPDATE_STATE call with resources '[]' and 0 operations from resource provider 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 I0906 09:24:11.336414 18625 slave.cpp:8481] Handling resource provider message 'UPDATE_STATE: 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 {}' I0906 09:24:11.336557 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call I0906 09:24:11.336519 18625 slave.cpp:8601] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0906 09:24:11.336993 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/GetCapacity call I0906 09:24:11.339365 18630 hierarchical.cpp:992] Grew agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 by {} (total), { } (used) I0906 09:24:11.339861 18630 hierarchical.cpp:950] Agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 (e22630eaba3d) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0906 09:24:11.340229 18630 hierarchical.cpp:1726] Performed allocation for 1 agents in 196741ns I0906 09:24:11.342344 18636 provider.cpp:808] Removing '{}' and adding 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001' to the total resources I0906 09:24:11.391376 18636 provider.cpp:2217] Sending UPDATE_STATE call with resources 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001' and 0 operations to agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 I0906 09:24:11.392009 18628 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.3:36221/slave(1247)/api/v1/resource_provider I0906 09:24:11.393800 18637 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1/resource_provider' I0906 09:24:11.397433 18633 hierarchical.cpp:1726] Performed allocation for 1 agents in 233883ns I0906 09:24:11.397789 18639 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:11.400916 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call I0906 09:24:11.401203 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/GetCapacity call I0906 09:24:11.405759 18637 provider.cpp:808] Removing '{}' and adding 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:0.001' to the total resources I0906 09:24:11.433634 18624 http.cpp:1115] HTTP POST for /slave(1247)/api/v1/resource_provider from 172.17.0.3:59022 I0906 09:24:11.434393 18630 manager.cpp:1045] Received UPDATE_STATE call with resources '[{"disk":{"source":{"id":"volume1","type":"RAW","vendor":"org.apache.mesos.csi.test.local"}},"name":"disk","provider_id":{"value":"2dfc3af3-5cd6-46bf-917c-a1dd58893cd4"},"reservations":[{"role":"storage","type":"DYNAMIC"}],"scalar":{"value":0.0009765625},"type":"SCALAR"}]' and 0 operations from resource provider 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 I0906 09:24:11.434875 18634 slave.cpp:8481] Handling resource provider message 'UPDATE_STATE: 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001' I0906 09:24:11.435019 18634 slave.cpp:8601] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001 I0906 09:24:11.437999 18622 hierarchical.cpp:950] Agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 (e22630eaba3d) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001 I0906 09:24:11.438596 18622 hierarchical.cpp:1726] Performed allocation for 1 agents in 265726ns I0906 09:24:11.450350 18637 provider.cpp:2217] Sending UPDATE_STATE call with resources 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:0.001' and 0 operations to agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 I0906 09:24:11.451192 18629 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.3:36221/slave(1247)/api/v1/resource_provider I0906 09:24:11.452582 18640 process.cpp:3671] Handling HTTP event for process 'slave(1247)' with path: '/slave(1247)/api/v1/resource_provider' I0906 09:24:11.454977 18623 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:11.455065 18621 hierarchical.cpp:1726] Performed allocation for 1 agents in 265862ns I0906 09:24:11.457844 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call I0906 09:24:11.458170 32866 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/GetCapacity call I0906 09:24:11.468588 18624 slave.cpp:924] Agent terminating I0906 09:24:11.469463 18624 manager.cpp:163] Terminating resource provider 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4 E0906 09:24:11.470717 18641 http_connection.hpp:452] End-Of-File received I0906 09:24:11.470850 18637 master.cpp:1297] Agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 at slave(1247)@172.17.0.3:36221 (e22630eaba3d) disconnected I0906 09:24:11.470906 18637 master.cpp:3399] Disconnecting agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 at slave(1247)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:11.470999 18637 master.cpp:3418] Deactivating agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 at slave(1247)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:11.471158 18626 hierarchical.cpp:1038] Agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 deactivated I0906 09:24:11.471539 18641 http_connection.hpp:217] Re-detecting endpoint E0906 09:24:11.471702 18633 provider.cpp:2225] Failed to update state for resource provider 2dfc3af3-5cd6-46bf-917c-a1dd58893cd4: Disconnected I0906 09:24:11.472762 18635 containerizer.cpp:2620] Destroying container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE in RUNNING state I0906 09:24:11.472811 18635 containerizer.cpp:3323] 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 30.732016896secs I0906 09:24:11.473314 18635 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:11.475762 18626 hierarchical.cpp:1726] Performed allocation for 1 agents in 240627ns I0906 09:24:11.527233 18642 hierarchical.cpp:1726] Performed allocation for 1 agents in 218352ns I0906 09:24:11.577736 18621 containerizer.cpp:3161] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE has exited I0906 09:24:11.579069 18641 hierarchical.cpp:1726] Performed allocation for 1 agents in 261940ns I0906 09:24:11.579380 18634 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 I0906 09:24:11.582137 18635 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' I0906 09:24:11.582365 18624 service_manager.cpp:723] Disconnected from endpoint 'unix:///tmp/mesos-csi-rkxOF7/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:11.582684 18623 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:11.589546 18643 process.cpp:2781] Returning '404 Not Found' for '/slave(1247)/api/v1' I0906 09:24:11.599860 18618 master.cpp:1137] Master terminating I0906 09:24:11.604355 18629 hierarchical.cpp:1014] Removed all filters for agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 I0906 09:24:11.604403 18629 hierarchical.cpp:891] Removed agent 27e43dbb-34b4-48da-a4e6-e6ff0c4eaae8-S0 [ OK ] CSIVersion/StorageLocalResourceProviderTest.Update/v0 (874 ms) [ RUN ] CSIVersion/StorageLocalResourceProviderTest.Update/v1 I0906 09:24:11.627717 18618 cluster.cpp:177] Creating default 'local' authorizer I0906 09:24:11.635259 18636 master.cpp:440] Master b8271543-8510-4750-ac82-ed06f1d07cf6 (e22630eaba3d) started on 172.17.0.3:36221 I0906 09:24:11.635323 18636 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/pJOWoq/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.10.0/_inst/share/mesos/webui" --work_dir="/tmp/pJOWoq/master" --zk_session_timeout="10secs" I0906 09:24:11.635999 18636 master.cpp:492] Master only allowing authenticated frameworks to register I0906 09:24:11.636068 18636 master.cpp:498] Master only allowing authenticated agents to register I0906 09:24:11.636122 18636 master.cpp:504] Master only allowing authenticated HTTP frameworks to register I0906 09:24:11.636175 18636 credentials.hpp:37] Loading credentials for authentication from '/tmp/pJOWoq/credentials' I0906 09:24:11.636652 18636 master.cpp:548] Using default 'crammd5' authenticator I0906 09:24:11.637051 18636 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly' I0906 09:24:11.637351 18636 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite' I0906 09:24:11.637526 18636 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler' I0906 09:24:11.637696 18636 master.cpp:629] Authorization enabled I0906 09:24:11.638218 18625 whitelist_watcher.cpp:77] No whitelist given I0906 09:24:11.638232 18638 hierarchical.cpp:474] Initialized hierarchical allocator process I0906 09:24:11.642246 18630 master.cpp:2170] Elected as the leading master! I0906 09:24:11.642674 18630 master.cpp:1666] Recovering from registrar I0906 09:24:11.643200 18622 registrar.cpp:339] Recovering registrar I0906 09:24:11.644452 18622 registrar.cpp:383] Successfully fetched the registry (0B) in 0ns I0906 09:24:11.644662 18622 registrar.cpp:487] Applied 1 operations in 66935ns; attempting to update the registry I0906 09:24:11.645707 18622 registrar.cpp:544] Successfully updated the registry in 0ns I0906 09:24:11.645898 18622 registrar.cpp:416] Successfully recovered registrar I0906 09:24:11.646587 18624 hierarchical.cpp:513] Skipping recovery of hierarchical allocator: nothing to recover I0906 09:24:11.646576 18627 master.cpp:1819] Recovered 0 agents from the registry (144B); allowing 10mins for agents to reregister W0906 09:24:11.653596 18618 process.cpp:2877] Attempted to spawn already running process files@172.17.0.3:36221 I0906 09:24:11.655192 18618 containerizer.cpp:318] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni } W0906 09:24:11.655838 18618 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges W0906 09:24:11.655866 18618 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges W0906 09:24:11.656013 18618 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges I0906 09:24:11.656056 18618 provisioner.cpp:300] Using default backend 'copy' I0906 09:24:11.658555 18618 cluster.cpp:518] Creating default 'local' authorizer I0906 09:24:11.661087 18633 slave.cpp:267] Mesos agent started on (1248)@172.17.0.3:36221 I0906 09:24:11.661136 18633 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://"; --appc_store_dir="/tmp/pJOWoq/rAwrDE/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/pJOWoq/rAwrDE/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/pJOWoq/rAwrDE/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/pJOWoq/rAwrDE/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/pJOWoq/rAwrDE/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/pJOWoq/rAwrDE/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.10.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/pJOWoq/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_Update_v1_nh7Jyl" --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_StorageLocalResourceProviderTest_Update_v1_NtA3t2" --zk_sessio n_timeout="10secs" I0906 09:24:11.661679 18633 credentials.hpp:86] Loading credential for authentication from '/tmp/pJOWoq/rAwrDE/credential' I0906 09:24:11.661927 18633 slave.cpp:300] Agent using credential for: test-principal I0906 09:24:11.661957 18633 credentials.hpp:37] Loading credentials for authentication from '/tmp/pJOWoq/rAwrDE/http_credentials' I0906 09:24:11.662184 18633 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly' I0906 09:24:11.662703 18633 disk_profile_adaptor.cpp:82] Creating disk profile adaptor module 'org_apache_mesos_UriDiskProfileAdaptor' I0906 09:24:11.664474 18633 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"}] I0906 09:24:11.664681 18633 slave.cpp:623] Agent attributes: [ ] I0906 09:24:11.664702 18633 slave.cpp:632] Agent hostname: e22630eaba3d I0906 09:24:11.664903 18638 task_status_update_manager.cpp:181] Pausing sending task status updates I0906 09:24:11.664901 18621 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:11.665035 18641 uri_disk_profile_adaptor.cpp:305] Updated disk profile mapping to 1 active profiles I0906 09:24:11.667381 18639 state.cpp:67] Recovering state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_NtA3t2/meta' I0906 09:24:11.667670 18630 slave.cpp:7491] Finished recovering checkpointed state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_NtA3t2/meta', beginning agent recovery I0906 09:24:11.668495 18630 task_status_update_manager.cpp:207] Recovering task status update manager I0906 09:24:11.668987 18642 containerizer.cpp:821] Recovering Mesos containers I0906 09:24:11.669489 18642 containerizer.cpp:1161] Recovering isolators I0906 09:24:11.670670 18620 containerizer.cpp:1200] Recovering provisioner I0906 09:24:11.671595 18621 provisioner.cpp:500] Provisioner recovery complete I0906 09:24:11.672987 18626 composing.cpp:339] Finished recovering all containerizers I0906 09:24:11.673599 18629 slave.cpp:7972] Recovering executors I0906 09:24:11.673712 18629 slave.cpp:8125] Finished recovery I0906 09:24:11.674939 18623 task_status_update_manager.cpp:181] Pausing sending task status updates I0906 09:24:11.674996 18632 slave.cpp:1351] New master detected at master@172.17.0.3:36221 I0906 09:24:11.675014 18623 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:11.675242 18632 slave.cpp:1416] Detecting new master I0906 09:24:11.676600 18642 slave.cpp:1443] Authenticating with master master@172.17.0.3:36221 I0906 09:24:11.676847 18642 slave.cpp:1452] Using default CRAM-MD5 authenticatee I0906 09:24:11.677403 18625 authenticatee.cpp:121] Creating new client SASL connection I0906 09:24:11.677901 18620 master.cpp:10617] Authenticating slave(1248)@172.17.0.3:36221 I0906 09:24:11.678083 18638 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(2106)@172.17.0.3:36221 I0906 09:24:11.678480 18641 authenticator.cpp:98] Creating new server SASL connection I0906 09:24:11.678903 18621 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5 I0906 09:24:11.678951 18621 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5' I0906 09:24:11.679132 18621 authenticator.cpp:204] Received SASL authentication start I0906 09:24:11.679220 18621 authenticator.cpp:326] Authentication requires more steps I0906 09:24:11.679404 18634 authenticatee.cpp:259] Received SASL authentication step I0906 09:24:11.679567 18634 authenticator.cpp:232] Received SASL authentication step I0906 09:24:11.679790 18634 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e22630eaba3d' server FQDN: 'e22630eaba3d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false I0906 09:24:11.679939 18634 auxprop.cpp:181] Looking up auxiliary property '*userPassword' I0906 09:24:11.680047 18634 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5' I0906 09:24:11.680089 18634 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: 'e22630eaba3d' server FQDN: 'e22630eaba3d' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true I0906 09:24:11.680110 18634 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true I0906 09:24:11.680124 18634 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true I0906 09:24:11.680177 18634 authenticator.cpp:318] Authentication success I0906 09:24:11.680449 18639 authenticatee.cpp:299] Authentication success I0906 09:24:11.680668 18635 master.cpp:10649] Successfully authenticated principal 'test-principal' at slave(1248)@172.17.0.3:36221 I0906 09:24:11.680785 18635 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(2106)@172.17.0.3:36221 I0906 09:24:11.681007 18634 slave.cpp:1543] Successfully authenticated with master master@172.17.0.3:36221 I0906 09:24:11.681659 18634 slave.cpp:1993] Will retry registration in 3.17755ms if necessary I0906 09:24:11.681936 18624 master.cpp:7088] Received register agent message from slave(1248)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:11.682456 18624 master.cpp:4204] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal' I0906 09:24:11.683596 18640 master.cpp:7155] Authorized registration of agent at slave(1248)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:11.683737 18640 master.cpp:7267] Registering agent at slave(1248)@172.17.0.3:36221 (e22630eaba3d) with id b8271543-8510-4750-ac82-ed06f1d07cf6-S0 I0906 09:24:11.684617 18632 registrar.cpp:487] Applied 1 operations in 329757ns; attempting to update the registry I0906 09:24:11.685840 18632 registrar.cpp:544] Successfully updated the registry in 0ns I0906 09:24:11.686089 18620 master.cpp:7315] Admitted agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 at slave(1248)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:11.687211 18620 master.cpp:7360] Registered agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 at slave(1248)@172.17.0.3:36221 (e22630eaba3d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0906 09:24:11.687376 18621 hierarchical.cpp:854] Added agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 (e22630eaba3d) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (offered or allocated: {}) I0906 09:24:11.687391 18641 slave.cpp:1576] Registered with master master@172.17.0.3:36221; given agent ID b8271543-8510-4750-ac82-ed06f1d07cf6-S0 I0906 09:24:11.687631 18633 task_status_update_manager.cpp:188] Resuming sending task status updates I0906 09:24:11.687809 18621 hierarchical.cpp:1726] Performed allocation for 1 agents in 165438ns I0906 09:24:11.688141 18641 slave.cpp:1611] Checkpointing SlaveInfo to '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_NtA3t2/meta/slaves/b8271543-8510-4750-ac82-ed06f1d07cf6-S0/slave.info' I0906 09:24:11.688199 18630 status_update_manager_process.hpp:385] Resuming operation status update manager I0906 09:24:11.690346 18641 slave.cpp:1663] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"TuffcMdKR3CpmIqySbcYzA=="},"slave_id":{"value":"b8271543-8510-4750-ac82-ed06f1d07cf6-S0"},"update_oversubscribed_resources":false} I0906 09:24:11.691514 18634 master.cpp:8487] Ignoring update on agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 at slave(1248)@172.17.0.3:36221 (e22630eaba3d) as it reports no changes I0906 09:24:11.698379 18632 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1' I0906 09:24:11.700058 18627 http.cpp:1115] HTTP POST for /slave(1248)/api/v1 from 172.17.0.3:59028 I0906 09:24:11.700847 18627 http.cpp:2146] Processing GET_CONTAINERS call I0906 09:24:11.709784 18622 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:11.714082 18633 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1' I0906 09:24:11.715569 18639 http.cpp:1115] HTTP POST for /slave(1248)/api/v1 from 172.17.0.3:59030 I0906 09:24:11.716959 18639 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' I0906 09:24:11.719149 18626 http.cpp:2710] Creating sandbox '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_NtA3t2/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:11.720094 18623 containerizer.cpp:1396] Starting container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:11.720919 18623 containerizer.cpp:3323] 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 I0906 09:24:11.721891 18623 containerizer.cpp:1574] Checkpointed ContainerConfig at '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_nh7Jyl/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config' I0906 09:24:11.721948 18623 containerizer.cpp:3323] 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 I0906 09:24:11.726164 18637 containerizer.cpp:2100] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["/mesos/mesos-1.10.0/_build/src/test-csi-plugin","--api_version=v1","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_80OopJ","--available_capacity=0B","--volumes=","--forward=unix:///tmp/pJOWoq/mock_csi.sock","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.10.0/_build/src/test-csi-plugin"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_NtA3t2/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-qQk8eS/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_NtA3t2/containers/org-apache-mesos-rp-local -storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}" --pipe_read="94" --pipe_write="95" --runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_nh7Jyl/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE" --unshare_namespace_mnt="false"' I0906 09:24:11.738395 18637 launcher.cpp:145] Forked child with pid '32879' for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:11.739848 18637 containerizer.cpp:3323] 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 I0906 09:24:11.741849 18637 containerizer.cpp:3323] 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 I0906 09:24:11.742352 18634 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_Update_v1_NtA3t2/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:11.743623 18634 containerizer.cpp:3323] 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 I0906 09:24:11.746572 18623 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' I0906 09:24:11.746870 18624 service_manager.cpp:703] Connecting to endpoint 'unix:///tmp/mesos-csi-qQk8eS/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:11.848557 18630 hierarchical.cpp:1726] Performed allocation for 1 agents in 250954ns I0906 09:24:11.900876 18634 hierarchical.cpp:1726] Performed allocation for 1 agents in 241382ns I0906 09:24:11.952054 18642 hierarchical.cpp:1726] Performed allocation for 1 agents in 262451ns I0906 09:24:12.003698 18620 hierarchical.cpp:1726] Performed allocation for 1 agents in 211237ns I0906 09:24:12.052685 18639 service_manager.cpp:545] Probing endpoint 'unix:///tmp/mesos-csi-qQk8eS/endpoint.sock' with CSI v1 I0906 09:24:12.054451 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/Probe call I0906 09:24:12.055111 18629 hierarchical.cpp:1726] Performed allocation for 1 agents in 213682ns I0906 09:24:12.056973 18619 container_daemon.cpp:171] Waiting for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:12.059824 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/GetPluginCapabilities call I0906 09:24:12.060066 18624 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1' I0906 09:24:12.061208 18641 http.cpp:1115] HTTP POST for /slave(1248)/api/v1 from 172.17.0.3:59032 I0906 09:24:12.061700 18641 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' I0906 09:24:12.064165 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/GetPluginInfo call I0906 09:24:12.064493 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/GetPluginInfo call I0906 09:24:12.065994 18638 v1_volume_manager.cpp:649] NODE_SERVICE loaded: {} I0906 09:24:12.066450 18638 v1_volume_manager.cpp:649] CONTROLLER_SERVICE loaded: {} I0906 09:24:12.068496 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ControllerGetCapabilities call I0906 09:24:12.071854 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Node/NodeGetCapabilities call I0906 09:24:12.075110 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Node/NodeGetInfo call I0906 09:24:12.077195 18619 provider.cpp:676] Recovered resources '{}' and 0 operations for resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test' I0906 09:24:12.077342 18633 status_update_manager_process.hpp:379] Pausing operation status update manager I0906 09:24:12.077780 18623 http_connection.hpp:227] New endpoint detected at http://172.17.0.3:36221/slave(1248)/api/v1/resource_provider I0906 09:24:12.081017 18635 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.3:36221/slave(1248)/api/v1/resource_provider I0906 09:24:12.081646 18637 provider.cpp:476] Connected to resource provider manager I0906 09:24:12.082207 18639 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.3:36221/slave(1248)/api/v1/resource_provider I0906 09:24:12.083457 18631 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider' I0906 09:24:12.085106 18619 http.cpp:1115] HTTP POST for /slave(1248)/api/v1/resource_provider from 172.17.0.3:59036 I0906 09:24:12.085875 18642 manager.cpp:813] Subscribing resource provider {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.10.0/_build/src/test-csi-plugin","--api_version=v1","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_80OopJ","--available_capacity=0B","--volumes=","--forward=unix:///tmp/pJOWoq/mock_csi.sock","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.10.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"},"reconciliation_interval_seconds":15.0},"type":"org.apache.mesos.rp.local.storage"} I0906 09:24:12.106432 18620 hierarchical.cpp:1726] Performed allocation for 1 agents in 198282ns I0906 09:24:12.114316 18635 slave.cpp:8481] Handling resource provider message 'SUBSCRIBE: {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3"},"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.10.0/_build/src/test-csi-plugin","--api_version=v1","--work_dir=/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_80OopJ","--available_capacity=0B","--volumes=","--forward=unix:///tmp/pJOWoq/mock_csi.sock","--create_parameters=","--volume_metadata="],"shell":false,"value":"/mesos/mesos-1.10.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"},"reconciliation_interval_seconds":15.0},"type":"org.apache.mesos.rp.local.storage"}' I0906 09:24:12.116152 18631 provider.cpp:498] Received SUBSCRIBED event I0906 09:24:12.116214 18631 provider.cpp:1309] Subscribed with ID acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 I0906 09:24:12.117029 18633 status_update_manager_process.hpp:314] Recovering operation status update manager I0906 09:24:12.155890 18640 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:12.157646 18622 hierarchical.cpp:1726] Performed allocation for 1 agents in 203131ns I0906 09:24:12.158468 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call I0906 09:24:12.160727 18635 provider.cpp:2217] Sending UPDATE_STATE call with resources '{}' and 0 operations to agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 I0906 09:24:12.161025 18637 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.3:36221/slave(1248)/api/v1/resource_provider I0906 09:24:12.161070 18635 provider.cpp:748] Resource provider acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 is in READY state I0906 09:24:12.161119 18641 status_update_manager_process.hpp:385] Resuming operation status update manager I0906 09:24:12.161645 18639 provider.cpp:1235] Updating profiles { test } for resource provider acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 I0906 09:24:12.162190 18633 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider' I0906 09:24:12.162732 18624 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:12.164155 18630 http.cpp:1115] HTTP POST for /slave(1248)/api/v1/resource_provider from 172.17.0.3:59034 I0906 09:24:12.164494 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call I0906 09:24:12.164696 18639 manager.cpp:1045] Received UPDATE_STATE call with resources '[]' and 0 operations from resource provider acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 I0906 09:24:12.164889 18628 slave.cpp:8481] Handling resource provider message 'UPDATE_STATE: acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 {}' I0906 09:24:12.164988 18628 slave.cpp:8601] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0906 09:24:12.165184 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/GetCapacity call I0906 09:24:12.167040 18641 hierarchical.cpp:992] Grew agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 by {} (total), { } (used) I0906 09:24:12.167342 18641 hierarchical.cpp:950] Agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 (e22630eaba3d) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000] I0906 09:24:12.168644 18628 provider.cpp:808] Removing '{}' and adding 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001' to the total resources I0906 09:24:12.206228 18628 provider.cpp:2217] Sending UPDATE_STATE call with resources 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001' and 0 operations to agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 I0906 09:24:12.206815 18619 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.3:36221/slave(1248)/api/v1/resource_provider I0906 09:24:12.208075 18620 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider' I0906 09:24:12.209447 18638 hierarchical.cpp:1726] Performed allocation for 1 agents in 251382ns I0906 09:24:12.209597 18641 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:12.212133 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call I0906 09:24:12.212429 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/GetCapacity call I0906 09:24:12.215988 18624 provider.cpp:808] Removing '{}' and adding 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:0.001' to the total resources I0906 09:24:12.248914 18634 http.cpp:1115] HTTP POST for /slave(1248)/api/v1/resource_provider from 172.17.0.3:59034 I0906 09:24:12.249617 18638 manager.cpp:1045] Received UPDATE_STATE call with resources '[{"disk":{"source":{"id":"volume1","type":"RAW","vendor":"org.apache.mesos.csi.test.local"}},"name":"disk","provider_id":{"value":"acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3"},"reservations":[{"role":"storage","type":"DYNAMIC"}],"scalar":{"value":0.0009765625},"type":"SCALAR"}]' and 0 operations from resource provider acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 I0906 09:24:12.250136 18630 slave.cpp:8481] Handling resource provider message 'UPDATE_STATE: acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001' I0906 09:24:12.250272 18630 slave.cpp:8601] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001 I0906 09:24:12.253020 18637 hierarchical.cpp:950] Agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 (e22630eaba3d) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001 I0906 09:24:12.253396 18637 hierarchical.cpp:1726] Performed allocation for 1 agents in 170675ns I0906 09:24:12.257064 18624 provider.cpp:2217] Sending UPDATE_STATE call with resources 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,volume1,)]:0.001; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local,,test)]:0.001' and 0 operations to agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 I0906 09:24:12.257673 18626 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.3:36221/slave(1248)/api/v1/resource_provider I0906 09:24:12.258950 18631 process.cpp:3671] Handling HTTP event for process 'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider' I0906 09:24:12.260910 18621 hierarchical.cpp:1726] Performed allocation for 1 agents in 150414ns I0906 09:24:12.261170 18636 provider.cpp:790] Reconciling storage pools and volumes I0906 09:24:12.264199 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call I0906 09:24:12.264609 32883 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/GetCapacity call I0906 09:24:12.274917 18642 slave.cpp:924] Agent terminating I0906 09:24:12.275691 18642 manager.cpp:163] Terminating resource provider acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3 I0906 09:24:12.276276 18639 master.cpp:1297] Agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 at slave(1248)@172.17.0.3:36221 (e22630eaba3d) disconnected I0906 09:24:12.276312 18639 master.cpp:3399] Disconnecting agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 at slave(1248)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:12.276389 18639 master.cpp:3418] Deactivating agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 at slave(1248)@172.17.0.3:36221 (e22630eaba3d) I0906 09:24:12.276536 18635 hierarchical.cpp:1038] Agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 deactivated E0906 09:24:12.276875 18626 http_connection.hpp:452] End-Of-File received I0906 09:24:12.277343 18626 http_connection.hpp:217] Re-detecting endpoint E0906 09:24:12.277503 18620 provider.cpp:2225] Failed to update state for resource provider acbc1bf6-6d49-4455-a317-0c2c0cd9c0f3: Disconnected I0906 09:24:12.278450 18642 containerizer.cpp:2620] Destroying container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE in RUNNING state I0906 09:24:12.278501 18642 containerizer.cpp:3323] 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 30.657976832secs I0906 09:24:12.278983 18642 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:12.281044 18635 hierarchical.cpp:1726] Performed allocation for 1 agents in 187931ns I0906 09:24:12.332289 18621 hierarchical.cpp:1726] Performed allocation for 1 agents in 233916ns I0906 09:24:12.382813 18623 containerizer.cpp:3161] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE has exited I0906 09:24:12.384164 18640 hierarchical.cpp:1726] Performed allocation for 1 agents in 239728ns I0906 09:24:12.384430 18630 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 I0906 09:24:12.387122 18633 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' I0906 09:24:12.387320 18622 service_manager.cpp:723] Disconnected from endpoint 'unix:///tmp/mesos-csi-qQk8eS/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE I0906 09:24:12.387528 18631 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE' I0906 09:24:12.390348 18643 process.cpp:2781] Returning '404 Not Found' for '/slave(1248)/api/v1' I0906 09:24:12.398985 18618 master.cpp:1137] Master terminating I0906 09:24:12.399771 18632 hierarchical.cpp:1014] Removed all filters for agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 I0906 09:24:12.399793 18632 hierarchical.cpp:891] Removed agent b8271543-8510-4750-ac82-ed06f1d07cf6-S0 [ OK ] CSIVersion/StorageLocalResourceProviderTest.Update/v1 (788 ms) [----------] 54 tests from CSIVersion/StorageLocalResourceProviderTest (98290 ms total) [----------] Global test environment tear-down [==========] 2318 tests from 221 test cases ran. (1072086 ms total) [ PASSED ] 2317 tests. [ FAILED ] 1 test, listed below: [ FAILED ] UriTest.SchemeHttp 1 FAILED TEST YOU HAVE 32 DISABLED TESTS I0906 09:24:12.504372 18643 process.cpp:935] Stopped the socket accept loop make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-1.10.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-1.10.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-1.10.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-1.10.0/_build' make: *** [distcheck] Error 1 + docker rmi --force mesos-1567751050-22726 Untagged: mesos-1567751050-22726:latest Deleted: sha256:cb6bb5350879769adacb83349e5a1c5da70a8edc19bf571b82faf2fe37ff0676 Deleted: sha256:3cd13508716d824e6cb69e5635002905cbca7378bf925ae680441f641220475d Deleted: sha256:1be784df09a2d30f9abb1bc7c7994015a4557bffc99184be965fd8b64a5d9b0c Deleted: sha256:5d05fe83f9e64b91f0c1547971f6da510e401fc17cceb8c162b226a68ca0c5ca Deleted: sha256:349d9d3e9a61cb2cf25754704fc90198a55111315fdc999faf7cdbc2e5f4e5e5 Deleted: sha256:149be5d1919cfb9c239d9a06c861c034b33f08f40b08dbf17261a4d932319c0e Deleted: sha256:3465b98e5e9f8cebd21649c4186e7a253e769d6fbefb4060535a33779512825c Deleted: sha256:ec87a04444d3375f3d2e6ebf60255452c4e4a523aeaf52283e5579e7913b9376 Deleted: sha256:9a694c4eed40f4de83438819946bdfc9fbe7040cf7a9269522ae729cd50a6191 Deleted: sha256:bdbbefbd244192824a620b3e759a1c731e4e1ad9419660918e79b43a6abb8c13 Deleted: sha256:49caf2d88d383b8d208947caa029b6718f75976b4ea43bc935e2acc262734fb6 Deleted: sha256:ea68c267c123423059c1c62d278c1a3963f35d4fc1145ea9a358258aceb0df25 Deleted: sha256:0a157bdce1914750c581ff62d62e3ff61c7809a9cd8f80dfa31d7ff3fa5a783e Deleted: sha256:0f6d0e4dbcc9b693ef7fb2b13fab17afe349852a43abedac034d23225d05bcb3 Deleted: sha256:d749f2bb524c67f0c11ec17ef5dae4bd762a7bde87a8e4206b03a646246f2a5b Deleted: sha256:795b0e3395a0e2a1fd713219e9f54cb9f02a25c2324087592749c918af60bc37 Deleted: sha256:7ab352cf61ae8a55db651dcdcfc50ab0d3b6ad047b9f864d414b56121861e701 Deleted: sha256:83c93e0ba8337c4a290f9ea411824053a6ff39445055c4504cd242a777aeee46 Deleted: sha256:1e31dc764c6dcaa3b8fe5e33a627fe53f8fa5d30f7be7bae4eb323e326a57c6b Deleted: sha256:d73aaf814c6231d69c3a3b20e05cfb17652dbf60dbbaed5a628dabfedd36a47c Deleted: sha256:8d2f71f1864fcb62bb4e66777ee0912659f9012b7eb037ce3a3aa6f7fb7017a5 Deleted: sha256:7218c975ec2eaeb6face690ba68106d09e1cd4de108b924ef9e9f43f87eefec7 Deleted: sha256:8aa257a8f585dcd7a112eaf3958b919e46703858ae18c9b32a83a25a27be3fea Deleted: sha256:6c1c928079120331c6ee88f1a2556bae7e530a42f10faf77085eaeb84a7ea195 Deleted: sha256:f1b57506f6819d659ffafd369296e79d1d0f56eb8b704459f0d1b424ca130a67 Deleted: sha256:9e534391699c8416450a7a947169a4e3277756e159336a661527d5103cd7450a Deleted: sha256:f7be12cdbd8a49421487fb9a092838e9e2c716ef8e1ca72c20c2452f2045efad Deleted: sha256:a8d29b70a88ff86ec6d29b89fa8dd0bd183d994f2af9acc042b7cd25d50fd3d9 Deleted: sha256:e4683d962bde81f15c934c7f6081d4b088f8872a9e72d2107a92ccc53463cd08 Deleted: sha256:8bbc13f594a553d10778879a96cca38069623881e81ad44609373947b93fe046 Full log: https://builds.apache.org/job/Mesos-Reviewbot-Linux/3524/console - Mesos Reviewbot On Sept. 6, 2019, 6:20 a.m., James Peach wrote: > > ----------------------------------------------------------- > This is an automatically generated e-mail. To reply, visit: > https://reviews.apache.org/r/71441/ > ----------------------------------------------------------- > > (Updated Sept. 6, 2019, 6:20 a.m.) > > > Review request for mesos, Gilbert Song and Jie Yu. > > > Bugs: MESOS-9963 > https://issues.apache.org/jira/browse/MESOS-9963 > > > Repository: mesos > > > Description > ------- > > If a non-default Docker registry is used for container image, the Docker > puller would omit the separator between the hostname and the path when > constructing the final URI. > > > Diffs > ----- > > src/tests/containerizer/docker_spec_tests.cpp > 4be0716895132e0406299f7d77f8ceb2d95dbe8a > src/uri/utils.cpp 3940dc041c1783eec9e7c950402fd7c42e620d8e > > > Diff: https://reviews.apache.org/r/71441/diff/1/ > > > Testing > ------- > > make check (Fedora 30) > > > Thanks, > > James Peach > >
