mesos-reviews mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Mesos Reviewbot <revi...@mesos.apache.org>
Subject Re: Review Request 71608: WIP: Supported destroying UCR container in `PROVISIONING` state.
Date Fri, 11 Oct 2019 17:32:25 GMT

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



Bad patch!

Reviews applied: [71608]

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_71608"]

Error:
...<truncated>...
LAR"}]'
I1011 17:32:07.722311 18989 sched.cpp:960] Rescinded offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O3
I1011 17:32:07.722419 18989 sched.cpp:971] Scheduler::offerRescinded took 28621ns
I1011 17:32:07.722991 18982 master.cpp:12706] Removing offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O3
I1011 17:32:07.723021 18970 hierarchical.cpp:1566] 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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,test)]:2048, offered or allocated: {}) on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 from framework 43815
 832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:07.725344 18970 hierarchical.cpp:1615] Framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 filtered agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 for 5secs
I1011 17:32:07.729540 18978 master.cpp:12571] Sending operation '' (uuid: 12b5f679-7049-418c-889e-a599bddaecf9) to agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 at slave(1249)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:07.730231 18981 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:07.733209 18977 master.cpp:6412] Processing REVIVE call for framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:07.733944 18988 hierarchical.cpp:1711] Unsuppressed offers and cleared filters for roles { storage/default-role } of framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:07.734148 18987 provider.cpp:498] Received APPLY_OPERATION event
I1011 17:32:07.734212 18987 provider.cpp:1351] Received CREATE operation '' (uuid: 12b5f679-7049-418c-889e-a599bddaecf9)
I1011 17:32:07.735894 18988 hierarchical.cpp:1843] Performed allocation for 1 agents in 1.596759ms
I1011 17:32:07.736515 18988 hierarchical.cpp:1843] Performed allocation for 1 agents in 261378ns
I1011 17:32:07.736927 18982 master.cpp:10409] Sending offers [ 43815832-d1a9-46d1-aecf-ab90f0b06204-O4 ] to framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:07.737850 18967 sched.cpp:934] Scheduler::resourceOffers took 112665ns
I1011 17:32:07.746440 18966 http.cpp:1115] HTTP POST for /slave(1249)/api/v1/resource_provider from 172.17.0.2:32910
I1011 17:32:07.748093 18979 slave.cpp:8483] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 58cfd2f9-be1a-4194-a8be-ab4a00efe898) for framework  (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)'
I1011 17:32:07.748378 18979 slave.cpp:8936] Updating the state of operation with no ID (uuid: 58cfd2f9-be1a-4194-a8be-ab4a00efe898) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I1011 17:32:07.748462 18979 slave.cpp:8690] Forwarding status update of operation with no ID (operation_uuid: 58cfd2f9-be1a-4194-a8be-ab4a00efe898) for an operator API call
I1011 17:32:07.749047 18975 master.cpp:12223] Updating the state of operation '' (uuid: 58cfd2f9-be1a-4194-a8be-ab4a00efe898) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I1011 17:32:07.749917 18983 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:07.928742 18967 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: c6d5b3cd-10fe-4945-8914-e346e5e0842c) for operation UUID 12b5f679-7049-418c-889e-a599bddaecf9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:07.928853 18967 status_update_manager_process.hpp:414] Creating operation status update stream 12b5f679-7049-418c-889e-a599bddaecf9 checkpoint=true
I1011 17:32:07.929091 18987 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event
I1011 17:32:07.929275 18967 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: c6d5b3cd-10fe-4945-8914-e346e5e0842c) for operation UUID 12b5f679-7049-418c-889e-a599bddaecf9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:07.995550 18967 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: c6d5b3cd-10fe-4945-8914-e346e5e0842c) for operation UUID 12b5f679-7049-418c-889e-a599bddaecf9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:07.996132 18967 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: 0aec94df-77c4-4c5a-b086-f645e9223f59) for stream 58cfd2f9-be1a-4194-a8be-ab4a00efe898
I1011 17:32:07.996248 18967 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 0aec94df-77c4-4c5a-b086-f645e9223f59) for operation UUID 58cfd2f9-be1a-4194-a8be-ab4a00efe898 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:07.996814 18970 http_connection.hpp:131] Sending UPDATE_OPERATION_STATUS call to http://172.17.0.2:33599/slave(1249)/api/v1/resource_provider
I1011 17:32:07.997947 18978 process.cpp:3671] Handling HTTP event for process 'slave(1249)' with path: '/slave(1249)/api/v1/resource_provider'
I1011 17:32:08.042366 18984 http.cpp:1115] HTTP POST for /slave(1249)/api/v1/resource_provider from 172.17.0.2:32910
I1011 17:32:08.044688 18986 slave.cpp:8483] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 12b5f679-7049-418c-889e-a599bddaecf9) for framework  (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)'
I1011 17:32:08.044992 18986 slave.cpp:8936] Updating the state of operation with no ID (uuid: 12b5f679-7049-418c-889e-a599bddaecf9) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I1011 17:32:08.045078 18986 slave.cpp:8690] Forwarding status update of operation with no ID (operation_uuid: 12b5f679-7049-418c-889e-a599bddaecf9) for an operator API call
I1011 17:32:08.045819 18983 master.cpp:12223] Updating the state of operation '' (uuid: 12b5f679-7049-418c-889e-a599bddaecf9) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I1011 17:32:08.046818 18977 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:08.049113 18971 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event
I1011 17:32:08.071213 18967 status_update_manager_process.hpp:490] Cleaning up operation status update stream 58cfd2f9-be1a-4194-a8be-ab4a00efe898
I1011 17:32:08.071624 18967 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: c6d5b3cd-10fe-4945-8914-e346e5e0842c) for stream 12b5f679-7049-418c-889e-a599bddaecf9
I1011 17:32:08.071758 18967 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: c6d5b3cd-10fe-4945-8914-e346e5e0842c) for operation UUID 12b5f679-7049-418c-889e-a599bddaecf9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.208323 18967 status_update_manager_process.hpp:490] Cleaning up operation status update stream 12b5f679-7049-418c-889e-a599bddaecf9
I1011 17:32:08.279335 18975 process.cpp:3671] Handling HTTP event for process 'master' with path: '/master/api/v1'
I1011 17:32:08.282202 18989 http.cpp:1115] HTTP POST for /master/api/v1 from 172.17.0.2:32938
I1011 17:32:08.282629 18989 http.cpp:263] Processing call DESTROY_VOLUMES
I1011 17:32:08.284024 18989 master.cpp:3983] Authorizing principal 'test-principal' to destroy volumes '[{"disk":{"persistence":{"id":"60de614b-966f-459a-9692-6c51dd57edf1","principal":"test-principal"},"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36","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":"e8f2339a-def5-4617-81e1-d3cd529050ff"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I1011 17:32:08.286646 18987 sched.cpp:960] Rescinded offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O4
I1011 17:32:08.286788 18987 sched.cpp:971] Scheduler::offerRescinded took 41728ns
I1011 17:32:08.287744 18972 master.cpp:12706] Removing offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O4
I1011 17:32:08.288281 18977 hierarchical.cpp:1566] 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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,test),60de614b-966f-459a-9692-6c51dd57edf1: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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,test),60de614b-966f-459a-9692-6c51dd57edf1:volume]:2048, offered
  or allocated: {}) on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 from framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:08.293323 18977 hierarchical.cpp:1615] Framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 filtered agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 for 5secs
I1011 17:32:08.300734 18969 master.cpp:12571] Sending operation '' (uuid: 9f382f57-db7d-487f-84c2-cb7acdf5e4f9) to agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 at slave(1249)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:08.301630 18966 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:08.306794 18985 provider.cpp:498] Received APPLY_OPERATION event
I1011 17:32:08.306874 18985 provider.cpp:1351] Received DESTROY operation '' (uuid: 9f382f57-db7d-487f-84c2-cb7acdf5e4f9)
I1011 17:32:08.309309 18976 hierarchical.cpp:1843] Performed allocation for 1 agents in 1.65923ms
I1011 17:32:08.309952 18982 master.cpp:10409] Sending offers [ 43815832-d1a9-46d1-aecf-ab90f0b06204-O5 ] to framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:08.310722 18987 sched.cpp:934] Scheduler::resourceOffers took 101091ns
I1011 17:32:08.475447 18972 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: c070a026-b400-4843-ac71-3188bb6b65cb) for operation UUID 9f382f57-db7d-487f-84c2-cb7acdf5e4f9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.475572 18972 status_update_manager_process.hpp:414] Creating operation status update stream 9f382f57-db7d-487f-84c2-cb7acdf5e4f9 checkpoint=true
I1011 17:32:08.475957 18972 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: c070a026-b400-4843-ac71-3188bb6b65cb) for operation UUID 9f382f57-db7d-487f-84c2-cb7acdf5e4f9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.592479 18972 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: c070a026-b400-4843-ac71-3188bb6b65cb) for operation UUID 9f382f57-db7d-487f-84c2-cb7acdf5e4f9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.593899 18970 http_connection.hpp:131] Sending UPDATE_OPERATION_STATUS call to http://172.17.0.2:33599/slave(1249)/api/v1/resource_provider
I1011 17:32:08.595429 18978 process.cpp:3671] Handling HTTP event for process 'slave(1249)' with path: '/slave(1249)/api/v1/resource_provider'
I1011 17:32:08.600657 18971 process.cpp:3671] Handling HTTP event for process 'master' with path: '/master/api/v1'
I1011 17:32:08.603193 18986 http.cpp:1115] HTTP POST for /master/api/v1 from 172.17.0.2:32946
I1011 17:32:08.603592 18986 http.cpp:263] Processing call UNRESERVE_RESOURCES
I1011 17:32:08.604720 18986 master.cpp:3875] Authorizing principal 'test-principal' to unreserve resources '[{"disk":{"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36","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":"e8f2339a-def5-4617-81e1-d3cd529050ff"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I1011 17:32:08.607251 18976 sched.cpp:960] Rescinded offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O5
I1011 17:32:08.607398 18976 sched.cpp:971] Scheduler::offerRescinded took 41732ns
I1011 17:32:08.608278 18982 hierarchical.cpp:1566] 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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,test)]:2048, offered or allocated: {}) on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 from framework 43815
 832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:08.608712 18983 master.cpp:12706] Removing offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O5
I1011 17:32:08.611335 18982 hierarchical.cpp:1615] Framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 filtered agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 for 5secs
I1011 17:32:08.615576 18972 master.cpp:12571] Sending operation '' (uuid: 5d5bf7d0-348a-4684-8bca-63ac723642b9) to agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 at slave(1249)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:08.616240 18972 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:08.620697 18986 provider.cpp:498] Received APPLY_OPERATION event
I1011 17:32:08.620767 18986 provider.cpp:1351] Received UNRESERVE operation '' (uuid: 5d5bf7d0-348a-4684-8bca-63ac723642b9)
I1011 17:32:08.621721 18966 hierarchical.cpp:1843] Performed allocation for 1 agents in 2.255362ms
I1011 17:32:08.622810 18989 master.cpp:10409] Sending offers [ 43815832-d1a9-46d1-aecf-ab90f0b06204-O6 ] to framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:08.623805 18976 sched.cpp:934] Scheduler::resourceOffers took 84338ns
I1011 17:32:08.638475 18980 http.cpp:1115] HTTP POST for /slave(1249)/api/v1/resource_provider from 172.17.0.2:32910
I1011 17:32:08.639947 18970 slave.cpp:8483] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 9f382f57-db7d-487f-84c2-cb7acdf5e4f9) for framework  (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)'
I1011 17:32:08.640285 18970 slave.cpp:8936] Updating the state of operation with no ID (uuid: 9f382f57-db7d-487f-84c2-cb7acdf5e4f9) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I1011 17:32:08.640369 18970 slave.cpp:8690] Forwarding status update of operation with no ID (operation_uuid: 9f382f57-db7d-487f-84c2-cb7acdf5e4f9) for an operator API call
I1011 17:32:08.640946 18969 master.cpp:12223] Updating the state of operation '' (uuid: 9f382f57-db7d-487f-84c2-cb7acdf5e4f9) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I1011 17:32:08.641782 18979 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:08.802947 18976 status_update_manager_process.hpp:152] Received operation status update OPERATION_FINISHED (Status UUID: 0756ceab-36a5-47a2-b240-df11ae5e3815) for operation UUID 5d5bf7d0-348a-4684-8bca-63ac723642b9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.803053 18986 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event
I1011 17:32:08.803078 18976 status_update_manager_process.hpp:414] Creating operation status update stream 5d5bf7d0-348a-4684-8bca-63ac723642b9 checkpoint=true
I1011 17:32:08.803490 18976 status_update_manager_process.hpp:929] Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status UUID: 0756ceab-36a5-47a2-b240-df11ae5e3815) for operation UUID 5d5bf7d0-348a-4684-8bca-63ac723642b9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.919968 18976 status_update_manager_process.hpp:528] Forwarding operation status update OPERATION_FINISHED (Status UUID: 0756ceab-36a5-47a2-b240-df11ae5e3815) for operation UUID 5d5bf7d0-348a-4684-8bca-63ac723642b9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.920675 18976 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: c070a026-b400-4843-ac71-3188bb6b65cb) for stream 9f382f57-db7d-487f-84c2-cb7acdf5e4f9
I1011 17:32:08.920799 18976 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: c070a026-b400-4843-ac71-3188bb6b65cb) for operation UUID 9f382f57-db7d-487f-84c2-cb7acdf5e4f9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:08.921561 18987 http_connection.hpp:131] Sending UPDATE_OPERATION_STATUS call to http://172.17.0.2:33599/slave(1249)/api/v1/resource_provider
I1011 17:32:08.923629 18977 process.cpp:3671] Handling HTTP event for process 'slave(1249)' with path: '/slave(1249)/api/v1/resource_provider'
I1011 17:32:08.966735 18967 http.cpp:1115] HTTP POST for /slave(1249)/api/v1/resource_provider from 172.17.0.2:32910
I1011 17:32:08.968436 18968 slave.cpp:8483] Handling resource provider message 'UPDATE_OPERATION_STATUS: (uuid: 5d5bf7d0-348a-4684-8bca-63ac723642b9) for framework  (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)'
I1011 17:32:08.968713 18968 slave.cpp:8936] Updating the state of operation with no ID (uuid: 5d5bf7d0-348a-4684-8bca-63ac723642b9) for an operation API call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I1011 17:32:08.968791 18968 slave.cpp:8690] Forwarding status update of operation with no ID (operation_uuid: 5d5bf7d0-348a-4684-8bca-63ac723642b9) for an operator API call
I1011 17:32:08.969354 18981 master.cpp:12223] Updating the state of operation '' (uuid: 5d5bf7d0-348a-4684-8bca-63ac723642b9) for an operator API call (latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I1011 17:32:08.970193 18975 slave.cpp:4352] Ignoring new checkpointed resources and operations identical to the current version
I1011 17:32:08.972651 18985 provider.cpp:498] Received ACKNOWLEDGE_OPERATION_STATUS event
I1011 17:32:09.003587 18976 status_update_manager_process.hpp:490] Cleaning up operation status update stream 9f382f57-db7d-487f-84c2-cb7acdf5e4f9
I1011 17:32:09.003875 18976 status_update_manager_process.hpp:252] Received operation status update acknowledgement (UUID: 0756ceab-36a5-47a2-b240-df11ae5e3815) for stream 5d5bf7d0-348a-4684-8bca-63ac723642b9
I1011 17:32:09.003947 18976 status_update_manager_process.hpp:929] Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID: 0756ceab-36a5-47a2-b240-df11ae5e3815) for operation UUID 5d5bf7d0-348a-4684-8bca-63ac723642b9 on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:09.104738 18976 status_update_manager_process.hpp:490] Cleaning up operation status update stream 5d5bf7d0-348a-4684-8bca-63ac723642b9
I1011 17:32:09.240272 18970 master.cpp:1411] Framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599 disconnected
I1011 17:32:09.240337 18970 master.cpp:3356] Deactivating framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:09.240828 18979 hierarchical.cpp:813] Deactivated framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:09.241439 18965 slave.cpp:924] Agent terminating
I1011 17:32:09.241564 18981 hierarchical.cpp:1566] 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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,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_3fAXuR/2GB-0e3a46a9-2bfd-4a7b-98e5-af47dc77ba36,test)]:2048, offered or allocated: {}) on agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 from framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:09.241919 18970 master.cpp:12706] Removing offer 43815832-d1a9-46d1-aecf-ab90f0b06204-O6
I1011 17:32:09.242035 18970 master.cpp:3333] Disconnecting framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:09.242133 18970 master.cpp:1426] Giving framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599 0ns to failover
I1011 17:32:09.242552 18965 manager.cpp:163] Terminating resource provider e8f2339a-def5-4617-81e1-d3cd529050ff
I1011 17:32:09.243307 18988 master.cpp:1296] Agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 at slave(1249)@172.17.0.2:33599 (5a7f1e158b5b) disconnected
I1011 17:32:09.243367 18988 master.cpp:3391] Disconnecting agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 at slave(1249)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:09.243505 18988 master.cpp:3410] Deactivating agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 at slave(1249)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:09.243707 18969 hierarchical.cpp:1146] Agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0 deactivated
I1011 17:32:09.243835 18988 master.cpp:10195] Framework failover timeout, removing framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
I1011 17:32:09.243882 18988 master.cpp:11197] Removing framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000 (default) at scheduler-068a09cf-d49f-47e2-9624-a4151c668a37@172.17.0.2:33599
E1011 17:32:09.244391 18979 http_connection.hpp:452] End-Of-File received
I1011 17:32:09.244555 18989 hierarchical.cpp:1767] Allocation paused
I1011 17:32:09.245041 18979 http_connection.hpp:217] Re-detecting endpoint
I1011 17:32:09.245345 18989 hierarchical.cpp:757] Removed framework 43815832-d1a9-46d1-aecf-ab90f0b06204-0000
I1011 17:32:09.245435 18989 hierarchical.cpp:1777] Allocation resumed
I1011 17:32:09.245609 18979 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I1011 17:32:09.245702 18979 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I1011 17:32:09.245769 18987 provider.cpp:488] Disconnected from resource provider manager
I1011 17:32:09.245810 18979 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:33599/slave(1249)/api/v1/resource_provider
I1011 17:32:09.246037 18985 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:09.247953 18968 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
I1011 17:32:09.248028 18968 containerizer.cpp:3318] 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.8004448secs
I1011 17:32:09.248661 18968 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:09.250646 18973 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:33599/slave(1249)/api/v1/resource_provider
I1011 17:32:09.251605 18982 provider.cpp:476] Connected to resource provider manager
I1011 17:32:09.252403 18987 hierarchical.cpp:1843] Performed allocation for 1 agents in 257886ns
I1011 17:32:09.252600 18970 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.2:33599/slave(1249)/api/v1/resource_provider
I1011 17:32:09.253932 18990 process.cpp:2781] Returning '404 Not Found' for '/slave(1249)/api/v1/resource_provider'
E1011 17:32:09.255872 18972 provider.cpp:721] Failed to subscribe resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test': Received '404 Not Found' ()
I1011 17:32:09.304340 18988 hierarchical.cpp:1843] Performed allocation for 1 agents in 323099ns
I1011 17:32:09.354904 18967 containerizer.cpp:3156] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE has exited
I1011 17:32:09.356209 18966 hierarchical.cpp:1843] Performed allocation for 1 agents in 264046ns
I1011 17:32:09.357302 18977 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
I1011 17:32:09.360949 18969 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'
I1011 17:32:09.361353 18971 service_manager.cpp:723] Disconnected from endpoint 'unix:///tmp/mesos-csi-ULoFCu/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:09.361742 18973 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:09.365876 18990 process.cpp:2781] Returning '404 Not Found' for '/slave(1249)/api/v1'
I1011 17:32:09.379830 18965 master.cpp:1137] Master terminating
I1011 17:32:09.382853 18979 hierarchical.cpp:1122] Removed all filters for agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
I1011 17:32:09.382896 18979 hierarchical.cpp:998] Removed agent 43815832-d1a9-46d1-aecf-ab90f0b06204-S0
[       OK ] CSIVersion/StorageLocalResourceProviderTest.OperatorOperationsWithResourceProviderResources/v1 (3698 ms)
[ RUN      ] CSIVersion/StorageLocalResourceProviderTest.Update/v0
I1011 17:32:09.404708 18965 cluster.cpp:177] Creating default 'local' authorizer
I1011 17:32:09.411835 18986 master.cpp:440] Master aba956f9-2151-49b4-a330-972357aafd7b (5a7f1e158b5b) started on 172.17.0.2:33599
I1011 17:32:09.411877 18986 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/nXIM1k/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/nXIM1k/master" --zk_session_timeout="10secs"
I1011 17:32:09.412405 18986 master.cpp:492] Master only allowing authenticated frameworks to register
I1011 17:32:09.412431 18986 master.cpp:498] Master only allowing authenticated agents to register
I1011 17:32:09.412444 18986 master.cpp:504] Master only allowing authenticated HTTP frameworks to register
I1011 17:32:09.412459 18986 credentials.hpp:37] Loading credentials for authentication from '/tmp/nXIM1k/credentials'
I1011 17:32:09.412837 18986 master.cpp:548] Using default 'crammd5' authenticator
I1011 17:32:09.413123 18986 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1011 17:32:09.413457 18986 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1011 17:32:09.413736 18986 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1011 17:32:09.414002 18986 master.cpp:629] Authorization enabled
I1011 17:32:09.414667 18970 whitelist_watcher.cpp:77] No whitelist given
I1011 17:32:09.414677 18978 hierarchical.cpp:567] Initialized hierarchical allocator process
I1011 17:32:09.419406 18966 master.cpp:2169] Elected as the leading master!
I1011 17:32:09.419464 18966 master.cpp:1665] Recovering from registrar
I1011 17:32:09.419854 18969 registrar.cpp:339] Recovering registrar
I1011 17:32:09.421196 18969 registrar.cpp:383] Successfully fetched the registry (0B) in 0ns
I1011 17:32:09.421404 18969 registrar.cpp:487] Applied 1 operations in 58934ns; attempting to update the registry
I1011 17:32:09.422430 18969 registrar.cpp:544] Successfully updated the registry in 0ns
I1011 17:32:09.422660 18969 registrar.cpp:416] Successfully recovered registrar
I1011 17:32:09.423382 18977 master.cpp:1818] Recovered 0 agents from the registry (144B); allowing 10mins for agents to reregister
I1011 17:32:09.423431 18987 hierarchical.cpp:606] Skipping recovery of hierarchical allocator: nothing to recover
W1011 17:32:09.432744 18965 process.cpp:2877] Attempted to spawn already running process files@172.17.0.2:33599
I1011 17:32:09.434952 18965 containerizer.cpp:318] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1011 17:32:09.435830 18965 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W1011 17:32:09.435878 18965 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1011 17:32:09.436122 18965 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1011 17:32:09.436192 18965 provisioner.cpp:300] Using default backend 'copy'
I1011 17:32:09.440373 18965 cluster.cpp:524] Creating default 'local' authorizer
I1011 17:32:09.444494 18980 slave.cpp:267] Mesos agent started on (1250)@172.17.0.2:33599
I1011 17:32:09.444543 18980 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/nXIM1k/UHN4oO/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/nXIM1k/UHN4oO/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/nXIM1k/UHN4oO/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/nXIM1k/UHN4oO/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/nXIM1k/UHN4oO/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/nXIM1k/UHN4oO/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/nXIM1k/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_gIzGxr" --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_g5kjG4" --zk_sessio
 n_timeout="10secs"
I1011 17:32:09.445411 18980 credentials.hpp:86] Loading credential for authentication from '/tmp/nXIM1k/UHN4oO/credential'
I1011 17:32:09.445729 18980 slave.cpp:300] Agent using credential for: test-principal
I1011 17:32:09.445772 18980 credentials.hpp:37] Loading credentials for authentication from '/tmp/nXIM1k/UHN4oO/http_credentials'
I1011 17:32:09.446133 18980 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1011 17:32:09.446756 18980 disk_profile_adaptor.cpp:82] Creating disk profile adaptor module 'org_apache_mesos_UriDiskProfileAdaptor'
I1011 17:32:09.447260 18967 hierarchical.cpp:1843] Performed allocation for 0 agents in 225421ns
I1011 17:32:09.448879 18968 uri_disk_profile_adaptor.cpp:305] Updated disk profile mapping to 1 active profiles
I1011 17:32:09.449625 18980 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"}]
I1011 17:32:09.450007 18980 slave.cpp:623] Agent attributes: [  ]
I1011 17:32:09.450047 18980 slave.cpp:632] Agent hostname: 5a7f1e158b5b
I1011 17:32:09.450361 18974 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:09.450381 18979 task_status_update_manager.cpp:181] Pausing sending task status updates
I1011 17:32:09.452769 18988 state.cpp:67] Recovering state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_g5kjG4/meta'
I1011 17:32:09.453122 18976 slave.cpp:7492] Finished recovering checkpointed state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_g5kjG4/meta', beginning agent recovery
I1011 17:32:09.454007 18989 task_status_update_manager.cpp:207] Recovering task status update manager
I1011 17:32:09.454802 18987 containerizer.cpp:821] Recovering Mesos containers
I1011 17:32:09.455421 18987 containerizer.cpp:1161] Recovering isolators
I1011 17:32:09.456997 18966 containerizer.cpp:1200] Recovering provisioner
I1011 17:32:09.458165 18979 provisioner.cpp:500] Provisioner recovery complete
I1011 17:32:09.459610 18982 composing.cpp:339] Finished recovering all containerizers
I1011 17:32:09.460047 18969 slave.cpp:7974] Recovering executors
I1011 17:32:09.460255 18969 slave.cpp:8127] Finished recovery
I1011 17:32:09.461478 18978 task_status_update_manager.cpp:181] Pausing sending task status updates
I1011 17:32:09.461539 18972 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:09.461558 18971 slave.cpp:1351] New master detected at master@172.17.0.2:33599
I1011 17:32:09.461761 18971 slave.cpp:1416] Detecting new master
I1011 17:32:09.463191 18977 slave.cpp:1443] Authenticating with master master@172.17.0.2:33599
I1011 17:32:09.463369 18977 slave.cpp:1452] Using default CRAM-MD5 authenticatee
I1011 17:32:09.463932 18967 authenticatee.cpp:121] Creating new client SASL connection
I1011 17:32:09.464494 18968 master.cpp:10594] Authenticating slave(1250)@172.17.0.2:33599
I1011 17:32:09.464736 18974 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(2112)@172.17.0.2:33599
I1011 17:32:09.465250 18973 authenticator.cpp:98] Creating new server SASL connection
I1011 17:32:09.465651 18979 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1011 17:32:09.465718 18979 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1011 17:32:09.465945 18985 authenticator.cpp:204] Received SASL authentication start
I1011 17:32:09.466053 18985 authenticator.cpp:326] Authentication requires more steps
I1011 17:32:09.466279 18980 authenticatee.cpp:259] Received SASL authentication step
I1011 17:32:09.466545 18976 authenticator.cpp:232] Received SASL authentication step
I1011 17:32:09.466619 18976 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5a7f1e158b5b' server FQDN: '5a7f1e158b5b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I1011 17:32:09.466645 18976 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1011 17:32:09.466706 18976 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1011 17:32:09.466751 18976 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5a7f1e158b5b' server FQDN: '5a7f1e158b5b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I1011 17:32:09.466775 18976 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1011 17:32:09.466796 18976 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1011 17:32:09.466843 18976 authenticator.cpp:318] Authentication success
I1011 17:32:09.467046 18983 authenticatee.cpp:299] Authentication success
I1011 17:32:09.467172 18988 master.cpp:10626] Successfully authenticated principal 'test-principal' at slave(1250)@172.17.0.2:33599
I1011 17:32:09.467243 18975 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(2112)@172.17.0.2:33599
I1011 17:32:09.467566 18989 slave.cpp:1543] Successfully authenticated with master master@172.17.0.2:33599
I1011 17:32:09.468189 18989 slave.cpp:1993] Will retry registration in 18.716963ms if necessary
I1011 17:32:09.468497 18981 master.cpp:7083] Received register agent message from slave(1250)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:09.469013 18981 master.cpp:4189] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1011 17:32:09.470021 18971 master.cpp:7150] Authorized registration of agent at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:09.470176 18971 master.cpp:7262] Registering agent at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b) with id aba956f9-2151-49b4-a330-972357aafd7b-S0
I1011 17:32:09.470957 18966 registrar.cpp:487] Applied 1 operations in 238584ns; attempting to update the registry
I1011 17:32:09.472018 18966 registrar.cpp:544] Successfully updated the registry in 975872ns
I1011 17:32:09.472371 18973 master.cpp:7310] Admitted agent aba956f9-2151-49b4-a330-972357aafd7b-S0 at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:09.473590 18973 master.cpp:7355] Registered agent aba956f9-2151-49b4-a330-972357aafd7b-S0 at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1011 17:32:09.473771 18985 slave.cpp:1576] Registered with master master@172.17.0.2:33599; given agent ID aba956f9-2151-49b4-a330-972357aafd7b-S0
I1011 17:32:09.473878 18980 hierarchical.cpp:955] Added agent aba956f9-2151-49b4-a330-972357aafd7b-S0 (5a7f1e158b5b) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (offered or allocated: {})
I1011 17:32:09.473958 18983 task_status_update_manager.cpp:188] Resuming sending task status updates
I1011 17:32:09.474470 18980 hierarchical.cpp:1843] Performed allocation for 1 agents in 238830ns
I1011 17:32:09.474520 18985 slave.cpp:1611] Checkpointing SlaveInfo to '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_g5kjG4/meta/slaves/aba956f9-2151-49b4-a330-972357aafd7b-S0/slave.info'
I1011 17:32:09.474674 18969 status_update_manager_process.hpp:385] Resuming operation status update manager
I1011 17:32:09.476253 18985 slave.cpp:1663] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"ixvqi9BhTIC3ECk8B5rwAg=="},"slave_id":{"value":"aba956f9-2151-49b4-a330-972357aafd7b-S0"},"update_oversubscribed_resources":false}
I1011 17:32:09.477308 18989 master.cpp:8474] Ignoring update on agent aba956f9-2151-49b4-a330-972357aafd7b-S0 at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b) as it reports no changes
I1011 17:32:09.483433 18974 process.cpp:3671] Handling HTTP event for process 'slave(1250)' with path: '/slave(1250)/api/v1'
I1011 17:32:09.485574 18980 http.cpp:1115] HTTP POST for /slave(1250)/api/v1 from 172.17.0.2:32972
I1011 17:32:09.486366 18980 http.cpp:2146] Processing GET_CONTAINERS call
I1011 17:32:09.494818 18977 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:09.498800 18966 hierarchical.cpp:1843] Performed allocation for 1 agents in 246470ns
I1011 17:32:09.499130 18973 process.cpp:3671] Handling HTTP event for process 'slave(1250)' with path: '/slave(1250)/api/v1'
I1011 17:32:09.500716 18982 http.cpp:1115] HTTP POST for /slave(1250)/api/v1 from 172.17.0.2:32974
I1011 17:32:09.502053 18982 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'
I1011 17:32:09.503450 18970 http.cpp:2710] Creating sandbox '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_g5kjG4/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:09.504346 18978 containerizer.cpp:1396] Starting container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:09.504922 18978 containerizer.cpp:3318] 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 214016ns
I1011 17:32:09.505547 18978 containerizer.cpp:1574] Checkpointed ContainerConfig at '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_gIzGxr/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config'
I1011 17:32:09.505596 18978 containerizer.cpp:3318] 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 674816ns
I1011 17:32:09.508989 18977 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_idOXOH","--available_capacity=0B","--volumes=","--forward=unix:///tmp/nXIM1k/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_g5kjG4/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-ee5zki/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_g5kjG4/containers/org-apache-mesos-rp-local
 -storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}" --pipe_read="96" --pipe_write="97" --runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_gIzGxr/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE" --unshare_namespace_mnt="false"'
I1011 17:32:09.526705 18977 launcher.cpp:145] Forked child with pid '840' for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:09.527724 18977 containerizer.cpp:3318] 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 22.119168ms
I1011 17:32:09.529768 18986 containerizer.cpp:3318] 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 1.862144ms
I1011 17:32:09.530467 18984 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_g5kjG4/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:09.532240 18985 containerizer.cpp:3318] 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 2.571008ms
I1011 17:32:09.536690 18972 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'
I1011 17:32:09.537140 18978 service_manager.cpp:703] Connecting to endpoint 'unix:///tmp/mesos-csi-ee5zki/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:09.550137 18968 hierarchical.cpp:1843] Performed allocation for 1 agents in 208869ns
I1011 17:32:09.601086 18977 hierarchical.cpp:1843] Performed allocation for 1 agents in 224625ns
I1011 17:32:09.653108 18971 hierarchical.cpp:1843] Performed allocation for 1 agents in 304451ns
I1011 17:32:09.704447 18967 hierarchical.cpp:1843] Performed allocation for 1 agents in 120621ns
I1011 17:32:09.756237 18973 hierarchical.cpp:1843] Performed allocation for 1 agents in 212234ns
I1011 17:32:09.808024 18986 hierarchical.cpp:1843] Performed allocation for 1 agents in 302368ns
I1011 17:32:09.859364 18987 hierarchical.cpp:1843] Performed allocation for 1 agents in 204623ns
I1011 17:32:09.911425 18974 hierarchical.cpp:1843] Performed allocation for 1 agents in 209206ns
I1011 17:32:09.963004 18969 hierarchical.cpp:1843] Performed allocation for 1 agents in 202466ns
I1011 17:32:10.014348 18971 hierarchical.cpp:1843] Performed allocation for 1 agents in 149037ns
I1011 17:32:10.066524 18988 hierarchical.cpp:1843] Performed allocation for 1 agents in 329942ns
I1011 17:32:10.086488 18966 service_manager.cpp:545] Probing endpoint 'unix:///tmp/mesos-csi-ee5zki/endpoint.sock' with CSI v1
I1011 17:32:10.090009 18973 service_manager.cpp:532] Probing endpoint 'unix:///tmp/mesos-csi-ee5zki/endpoint.sock' with CSI v0
I1011 17:32:10.091545   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/Probe call
I1011 17:32:10.095320 18969 container_daemon.cpp:171] Waiting for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:10.099112   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/GetPluginCapabilities call
I1011 17:32:10.099812 18987 process.cpp:3671] Handling HTTP event for process 'slave(1250)' with path: '/slave(1250)/api/v1'
I1011 17:32:10.101601 18978 http.cpp:1115] HTTP POST for /slave(1250)/api/v1 from 172.17.0.2:32982
I1011 17:32:10.102461 18978 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'
I1011 17:32:10.105080   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/GetPluginInfo call
I1011 17:32:10.105497   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Identity/GetPluginInfo call
I1011 17:32:10.108016 18986 v0_volume_manager.cpp:628] NODE_SERVICE loaded: {}
I1011 17:32:10.108779 18986 v0_volume_manager.cpp:628] CONTROLLER_SERVICE loaded: {}
I1011 17:32:10.111917   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ControllerGetCapabilities call
I1011 17:32:10.116628   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Node/NodeGetCapabilities call
I1011 17:32:10.118003 18966 hierarchical.cpp:1843] Performed allocation for 1 agents in 164507ns
I1011 17:32:10.121140   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Node/NodeGetId call
I1011 17:32:10.124632 18982 provider.cpp:676] Recovered resources '{}' and 0 operations for resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test'
I1011 17:32:10.124824 18977 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:10.125349 18967 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.129258 18970 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.130100 18979 provider.cpp:476] Connected to resource provider manager
I1011 17:32:10.131264 18972 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.133158 18978 process.cpp:3671] Handling HTTP event for process 'slave(1250)' with path: '/slave(1250)/api/v1/resource_provider'
I1011 17:32:10.136093 18982 http.cpp:1115] HTTP POST for /slave(1250)/api/v1/resource_provider from 172.17.0.2:32988
I1011 17:32:10.137189 18980 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_idOXOH","--available_capacity=0B","--volumes=","--forward=unix:///tmp/nXIM1k/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"}
I1011 17:32:10.169188 18987 hierarchical.cpp:1843] Performed allocation for 1 agents in 193026ns
I1011 17:32:10.183692 18988 slave.cpp:8483] Handling resource provider message 'SUBSCRIBE: {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"d813134e-7088-4746-9f10-18cad1b7ce3f"},"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_idOXOH","--available_capacity=0B","--volumes=","--forward=unix:///tmp/nXIM1k/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"}'
I1011 17:32:10.186372 18976 provider.cpp:498] Received SUBSCRIBED event
I1011 17:32:10.186439 18976 provider.cpp:1309] Subscribed with ID d813134e-7088-4746-9f10-18cad1b7ce3f
I1011 17:32:10.187608 18982 status_update_manager_process.hpp:314] Recovering operation status update manager
I1011 17:32:10.220275 18986 hierarchical.cpp:1843] Performed allocation for 1 agents in 212706ns
I1011 17:32:10.271380 18971 hierarchical.cpp:1843] Performed allocation for 1 agents in 187996ns
I1011 17:32:10.300096 18980 provider.cpp:790] Reconciling storage pools and volumes
I1011 17:32:10.303123   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call
I1011 17:32:10.307312 18983 provider.cpp:2217] Sending UPDATE_STATE call with resources '{}' and 0 operations to agent aba956f9-2151-49b4-a330-972357aafd7b-S0
I1011 17:32:10.307761 18976 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.307834 18983 provider.cpp:748] Resource provider d813134e-7088-4746-9f10-18cad1b7ce3f is in READY state
I1011 17:32:10.307957 18982 status_update_manager_process.hpp:385] Resuming operation status update manager
I1011 17:32:10.308986 18971 provider.cpp:1235] Updating profiles { test } for resource provider d813134e-7088-4746-9f10-18cad1b7ce3f
I1011 17:32:10.309381 18980 process.cpp:3671] Handling HTTP event for process 'slave(1250)' with path: '/slave(1250)/api/v1/resource_provider'
I1011 17:32:10.310727 18975 provider.cpp:790] Reconciling storage pools and volumes
I1011 17:32:10.312202 18974 http.cpp:1115] HTTP POST for /slave(1250)/api/v1/resource_provider from 172.17.0.2:32986
I1011 17:32:10.313040 18976 manager.cpp:1045] Received UPDATE_STATE call with resources '[]' and 0 operations from resource provider d813134e-7088-4746-9f10-18cad1b7ce3f
I1011 17:32:10.313416 18983 slave.cpp:8483] Handling resource provider message 'UPDATE_STATE: d813134e-7088-4746-9f10-18cad1b7ce3f {}'
I1011 17:32:10.313581 18983 slave.cpp:8603] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1011 17:32:10.315063   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call
I1011 17:32:10.315696   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/GetCapacity call
I1011 17:32:10.315712 18969 hierarchical.cpp:1100] Grew agent aba956f9-2151-49b4-a330-972357aafd7b-S0 by {} (total), {  } (used)
I1011 17:32:10.316309 18969 hierarchical.cpp:1057] Agent aba956f9-2151-49b4-a330-972357aafd7b-S0 (5a7f1e158b5b) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1011 17:32:10.323580 18972 hierarchical.cpp:1843] Performed allocation for 1 agents in 376236ns
I1011 17:32:10.324025 18968 provider.cpp:790] Reconciling storage pools and volumes
I1011 17:32:10.327754   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/ListVolumes call
I1011 17:32:10.328591   844 test_csi_plugin.cpp:1915] Forwarding /csi.v0.Controller/GetCapacity call
I1011 17:32:10.338985 18972 slave.cpp:924] Agent terminating
I1011 17:32:10.340463 18972 manager.cpp:163] Terminating resource provider d813134e-7088-4746-9f10-18cad1b7ce3f
I1011 17:32:10.341285 18978 master.cpp:1296] Agent aba956f9-2151-49b4-a330-972357aafd7b-S0 at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b) disconnected
I1011 17:32:10.341347 18978 master.cpp:3391] Disconnecting agent aba956f9-2151-49b4-a330-972357aafd7b-S0 at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:10.341480 18978 master.cpp:3410] Deactivating agent aba956f9-2151-49b4-a330-972357aafd7b-S0 at slave(1250)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:10.341684 18982 hierarchical.cpp:1146] Agent aba956f9-2151-49b4-a330-972357aafd7b-S0 deactivated
E1011 17:32:10.342003 18985 http_connection.hpp:452] End-Of-File received
I1011 17:32:10.342566 18985 http_connection.hpp:217] Re-detecting endpoint
I1011 17:32:10.343235 18985 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I1011 17:32:10.343348 18985 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I1011 17:32:10.343417 18980 provider.cpp:488] Disconnected from resource provider manager
I1011 17:32:10.343494 18985 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.343648 18969 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:10.345844 18976 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
I1011 17:32:10.345927 18976 containerizer.cpp:3318] 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 15.813772032secs
I1011 17:32:10.346513 18976 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:10.348847 18971 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.349750 18981 provider.cpp:476] Connected to resource provider manager
I1011 17:32:10.350617 18966 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.2:33599/slave(1250)/api/v1/resource_provider
I1011 17:32:10.351797 18990 process.cpp:2781] Returning '404 Not Found' for '/slave(1250)/api/v1/resource_provider'
E1011 17:32:10.353917 18977 provider.cpp:721] Failed to subscribe resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test': Received '404 Not Found' ()
I1011 17:32:10.369268 18985 hierarchical.cpp:1843] Performed allocation for 1 agents in 283919ns
I1011 17:32:10.420194 18972 containerizer.cpp:3156] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE has exited
I1011 17:32:10.421061 18978 hierarchical.cpp:1843] Performed allocation for 1 agents in 294845ns
I1011 17:32:10.423142 18986 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
I1011 17:32:10.426434 18973 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'
I1011 17:32:10.426802 18985 service_manager.cpp:723] Disconnected from endpoint 'unix:///tmp/mesos-csi-ee5zki/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:10.427287 18979 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:10.430989 18990 process.cpp:2781] Returning '404 Not Found' for '/slave(1250)/api/v1'
I1011 17:32:10.445958 18965 master.cpp:1137] Master terminating
I1011 17:32:10.446712 18974 hierarchical.cpp:1122] Removed all filters for agent aba956f9-2151-49b4-a330-972357aafd7b-S0
I1011 17:32:10.446754 18974 hierarchical.cpp:998] Removed agent aba956f9-2151-49b4-a330-972357aafd7b-S0
[       OK ] CSIVersion/StorageLocalResourceProviderTest.Update/v0 (1061 ms)
[ RUN      ] CSIVersion/StorageLocalResourceProviderTest.Update/v1
I1011 17:32:10.470314 18965 cluster.cpp:177] Creating default 'local' authorizer
I1011 17:32:10.478860 18967 master.cpp:440] Master b23420ec-e0a8-4c91-9555-c1493e416b6c (5a7f1e158b5b) started on 172.17.0.2:33599
I1011 17:32:10.478914 18967 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/Yv6fnA/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/Yv6fnA/master" --zk_session_timeout="10secs"
I1011 17:32:10.479439 18967 master.cpp:492] Master only allowing authenticated frameworks to register
I1011 17:32:10.479465 18967 master.cpp:498] Master only allowing authenticated agents to register
I1011 17:32:10.479478 18967 master.cpp:504] Master only allowing authenticated HTTP frameworks to register
I1011 17:32:10.479496 18967 credentials.hpp:37] Loading credentials for authentication from '/tmp/Yv6fnA/credentials'
I1011 17:32:10.479934 18967 master.cpp:548] Using default 'crammd5' authenticator
I1011 17:32:10.480345 18967 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I1011 17:32:10.480705 18967 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I1011 17:32:10.481014 18967 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I1011 17:32:10.481318 18967 master.cpp:629] Authorization enabled
I1011 17:32:10.481837 18973 hierarchical.cpp:567] Initialized hierarchical allocator process
I1011 17:32:10.481946 18972 whitelist_watcher.cpp:77] No whitelist given
I1011 17:32:10.486608 18983 master.cpp:2169] Elected as the leading master!
I1011 17:32:10.486666 18983 master.cpp:1665] Recovering from registrar
I1011 17:32:10.487023 18979 registrar.cpp:339] Recovering registrar
I1011 17:32:10.488319 18979 registrar.cpp:383] Successfully fetched the registry (0B) in 0ns
I1011 17:32:10.488541 18979 registrar.cpp:487] Applied 1 operations in 67854ns; attempting to update the registry
I1011 17:32:10.489622 18979 registrar.cpp:544] Successfully updated the registry in 0ns
I1011 17:32:10.489868 18979 registrar.cpp:416] Successfully recovered registrar
I1011 17:32:10.490630 18989 master.cpp:1818] Recovered 0 agents from the registry (144B); allowing 10mins for agents to reregister
I1011 17:32:10.490742 18986 hierarchical.cpp:606] Skipping recovery of hierarchical allocator: nothing to recover
W1011 17:32:10.498311 18965 process.cpp:2877] Attempted to spawn already running process files@172.17.0.2:33599
I1011 17:32:10.499965 18965 containerizer.cpp:318] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W1011 17:32:10.500769 18965 backend.cpp:76] Failed to create 'overlay' backend: OverlayBackend requires root privileges
W1011 17:32:10.500805 18965 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W1011 17:32:10.500968 18965 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I1011 17:32:10.501014 18965 provisioner.cpp:300] Using default backend 'copy'
I1011 17:32:10.504508 18965 cluster.cpp:524] Creating default 'local' authorizer
I1011 17:32:10.508239 18984 slave.cpp:267] Mesos agent started on (1251)@172.17.0.2:33599
I1011 17:32:10.508293 18984 slave.cpp:268] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/Yv6fnA/IkbBwd/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/Yv6fnA/IkbBwd/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/Yv6fnA/IkbBwd/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/Yv6fnA/IkbBwd/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/Yv6fnA/IkbBwd/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/Yv6fnA/IkbBwd/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/Yv6fnA/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_7Q5BdO" --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_u6LDUo" --zk_sessio
 n_timeout="10secs"
I1011 17:32:10.509213 18984 credentials.hpp:86] Loading credential for authentication from '/tmp/Yv6fnA/IkbBwd/credential'
I1011 17:32:10.509585 18984 slave.cpp:300] Agent using credential for: test-principal
I1011 17:32:10.509627 18984 credentials.hpp:37] Loading credentials for authentication from '/tmp/Yv6fnA/IkbBwd/http_credentials'
I1011 17:32:10.509999 18984 http.cpp:975] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I1011 17:32:10.510730 18984 disk_profile_adaptor.cpp:82] Creating disk profile adaptor module 'org_apache_mesos_UriDiskProfileAdaptor'
I1011 17:32:10.510820 18985 hierarchical.cpp:1843] Performed allocation for 0 agents in 207223ns
I1011 17:32:10.513130 18982 uri_disk_profile_adaptor.cpp:305] Updated disk profile mapping to 1 active profiles
I1011 17:32:10.513602 18984 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"}]
I1011 17:32:10.513990 18984 slave.cpp:623] Agent attributes: [  ]
I1011 17:32:10.514017 18984 slave.cpp:632] Agent hostname: 5a7f1e158b5b
I1011 17:32:10.514323 18983 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:10.514355 18988 task_status_update_manager.cpp:181] Pausing sending task status updates
I1011 17:32:10.517319 18974 state.cpp:67] Recovering state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_u6LDUo/meta'
I1011 17:32:10.517661 18981 slave.cpp:7492] Finished recovering checkpointed state from '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_u6LDUo/meta', beginning agent recovery
I1011 17:32:10.518571 18971 task_status_update_manager.cpp:207] Recovering task status update manager
I1011 17:32:10.519376 18971 containerizer.cpp:821] Recovering Mesos containers
I1011 17:32:10.520128 18971 containerizer.cpp:1161] Recovering isolators
I1011 17:32:10.521414 18982 containerizer.cpp:1200] Recovering provisioner
I1011 17:32:10.522635 18987 provisioner.cpp:500] Provisioner recovery complete
I1011 17:32:10.523847 18977 composing.cpp:339] Finished recovering all containerizers
I1011 17:32:10.524371 18980 slave.cpp:7974] Recovering executors
I1011 17:32:10.524556 18980 slave.cpp:8127] Finished recovery
I1011 17:32:10.525887 18978 task_status_update_manager.cpp:181] Pausing sending task status updates
I1011 17:32:10.525949 18976 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:10.525985 18967 slave.cpp:1351] New master detected at master@172.17.0.2:33599
I1011 17:32:10.526166 18967 slave.cpp:1416] Detecting new master
I1011 17:32:10.532718 18972 slave.cpp:1443] Authenticating with master master@172.17.0.2:33599
I1011 17:32:10.532941 18972 slave.cpp:1452] Using default CRAM-MD5 authenticatee
I1011 17:32:10.533536 18982 authenticatee.cpp:121] Creating new client SASL connection
I1011 17:32:10.534112 18983 master.cpp:10594] Authenticating slave(1251)@172.17.0.2:33599
I1011 17:32:10.534421 18988 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(2113)@172.17.0.2:33599
I1011 17:32:10.534916 18975 authenticator.cpp:98] Creating new server SASL connection
I1011 17:32:10.535392 18974 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I1011 17:32:10.535461 18974 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I1011 17:32:10.535686 18984 authenticator.cpp:204] Received SASL authentication start
I1011 17:32:10.535807 18984 authenticator.cpp:326] Authentication requires more steps
I1011 17:32:10.536022 18968 authenticatee.cpp:259] Received SASL authentication step
I1011 17:32:10.536321 18969 authenticator.cpp:232] Received SASL authentication step
I1011 17:32:10.536391 18969 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5a7f1e158b5b' server FQDN: '5a7f1e158b5b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false 
I1011 17:32:10.536432 18969 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I1011 17:32:10.536523 18969 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I1011 17:32:10.536576 18969 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '5a7f1e158b5b' server FQDN: '5a7f1e158b5b' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true 
I1011 17:32:10.536598 18969 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I1011 17:32:10.536617 18969 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I1011 17:32:10.536664 18969 authenticator.cpp:318] Authentication success
I1011 17:32:10.536880 18979 authenticatee.cpp:299] Authentication success
I1011 17:32:10.537055 18987 master.cpp:10626] Successfully authenticated principal 'test-principal' at slave(1251)@172.17.0.2:33599
I1011 17:32:10.537133 18989 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(2113)@172.17.0.2:33599
I1011 17:32:10.537575 18981 slave.cpp:1543] Successfully authenticated with master master@172.17.0.2:33599
I1011 17:32:10.538173 18981 slave.cpp:1993] Will retry registration in 378582ns if necessary
I1011 17:32:10.538427 18973 master.cpp:7083] Received register agent message from slave(1251)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:10.538904 18973 master.cpp:4189] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I1011 17:32:10.539968 18967 master.cpp:7150] Authorized registration of agent at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:10.540212 18967 master.cpp:7262] Registering agent at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b) with id b23420ec-e0a8-4c91-9555-c1493e416b6c-S0
I1011 17:32:10.540308 18976 slave.cpp:1993] Will retry registration in 39.218827ms if necessary
I1011 17:32:10.540784 18967 master.cpp:7076] Ignoring register agent message from slave(1251)@172.17.0.2:33599 (5a7f1e158b5b) as registration is already in progress
I1011 17:32:10.541219 18976 registrar.cpp:487] Applied 1 operations in 330212ns; attempting to update the registry
I1011 17:32:10.542464 18975 registrar.cpp:544] Successfully updated the registry in 1.126144ms
I1011 17:32:10.542802 18974 master.cpp:7310] Admitted agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:10.543993 18974 master.cpp:7355] Registered agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1011 17:32:10.544095 18968 slave.cpp:1576] Registered with master master@172.17.0.2:33599; given agent ID b23420ec-e0a8-4c91-9555-c1493e416b6c-S0
I1011 17:32:10.544258 18974 task_status_update_manager.cpp:188] Resuming sending task status updates
I1011 17:32:10.544361 18977 hierarchical.cpp:955] Added agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 (5a7f1e158b5b) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (offered or allocated: {})
I1011 17:32:10.544921 18968 slave.cpp:1611] Checkpointing SlaveInfo to '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_u6LDUo/meta/slaves/b23420ec-e0a8-4c91-9555-c1493e416b6c-S0/slave.info'
I1011 17:32:10.544915 18977 hierarchical.cpp:1843] Performed allocation for 1 agents in 244688ns
I1011 17:32:10.545012 18969 status_update_manager_process.hpp:385] Resuming operation status update manager
I1011 17:32:10.546782 18968 slave.cpp:1663] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"oAs+AIK6TIaf8k5r25kS0w=="},"slave_id":{"value":"b23420ec-e0a8-4c91-9555-c1493e416b6c-S0"},"update_oversubscribed_resources":false}
I1011 17:32:10.548130 18973 master.cpp:8474] Ignoring update on agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b) as it reports no changes
I1011 17:32:10.553941 18984 process.cpp:3671] Handling HTTP event for process 'slave(1251)' with path: '/slave(1251)/api/v1'
I1011 17:32:10.556108 18979 http.cpp:1115] HTTP POST for /slave(1251)/api/v1 from 172.17.0.2:33000
I1011 17:32:10.556907 18979 http.cpp:2146] Processing GET_CONTAINERS call
I1011 17:32:10.562152 18967 hierarchical.cpp:1843] Performed allocation for 1 agents in 314448ns
I1011 17:32:10.566542 18972 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:10.570724 18977 process.cpp:3671] Handling HTTP event for process 'slave(1251)' with path: '/slave(1251)/api/v1'
I1011 17:32:10.572391 18978 http.cpp:1115] HTTP POST for /slave(1251)/api/v1 from 172.17.0.2:33002
I1011 17:32:10.573455 18978 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'
I1011 17:32:10.574753 18971 http.cpp:2710] Creating sandbox '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_u6LDUo/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:10.575726 18973 containerizer.cpp:1396] Starting container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:10.576632 18973 containerizer.cpp:3318] 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 355840ns
I1011 17:32:10.577644 18973 containerizer.cpp:1574] Checkpointed ContainerConfig at '/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_7Q5BdO/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config'
I1011 17:32:10.577747 18973 containerizer.cpp:3318] 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 1.108224ms
I1011 17:32:10.582175 18987 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_hzIGBZ","--available_capacity=0B","--volumes=","--forward=unix:///tmp/Yv6fnA/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_u6LDUo/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-nRn3fR/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_u6LDUo/containers/org-apache-mesos-rp-local
 -storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}" --pipe_read="96" --pipe_write="97" --runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_7Q5BdO/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE" --unshare_namespace_mnt="false"'
I1011 17:32:10.601450 18987 launcher.cpp:145] Forked child with pid '854' for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:10.602957 18987 containerizer.cpp:3318] 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 25.200896ms
I1011 17:32:10.605415 18987 containerizer.cpp:3318] 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 2.427136ms
I1011 17:32:10.606053 18980 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_u6LDUo/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:10.607844 18978 containerizer.cpp:3318] 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 2.385664ms
I1011 17:32:10.611099 18983 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'
I1011 17:32:10.611301 18967 service_manager.cpp:703] Connecting to endpoint 'unix:///tmp/mesos-csi-nRn3fR/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:10.613365 18974 hierarchical.cpp:1843] Performed allocation for 1 agents in 325142ns
I1011 17:32:10.665447 18989 hierarchical.cpp:1843] Performed allocation for 1 agents in 317221ns
I1011 17:32:10.717315 18986 hierarchical.cpp:1843] Performed allocation for 1 agents in 305819ns
I1011 17:32:10.769117 18976 hierarchical.cpp:1843] Performed allocation for 1 agents in 299250ns
I1011 17:32:10.821151 18984 hierarchical.cpp:1843] Performed allocation for 1 agents in 287681ns
I1011 17:32:10.873113 18987 hierarchical.cpp:1843] Performed allocation for 1 agents in 324273ns
I1011 17:32:10.925689 18973 hierarchical.cpp:1843] Performed allocation for 1 agents in 341402ns
I1011 17:32:10.977267 18967 hierarchical.cpp:1843] Performed allocation for 1 agents in 366188ns
I1011 17:32:11.029059 18979 hierarchical.cpp:1843] Performed allocation for 1 agents in 285541ns
I1011 17:32:11.080720 18971 hierarchical.cpp:1843] Performed allocation for 1 agents in 307951ns
I1011 17:32:11.108355 18988 service_manager.cpp:545] Probing endpoint 'unix:///tmp/mesos-csi-nRn3fR/endpoint.sock' with CSI v1
I1011 17:32:11.110779   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/Probe call
I1011 17:32:11.114922 18981 container_daemon.cpp:171] Waiting for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:11.119226   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/GetPluginCapabilities call
I1011 17:32:11.119767 18968 process.cpp:3671] Handling HTTP event for process 'slave(1251)' with path: '/slave(1251)/api/v1'
I1011 17:32:11.121786 18982 http.cpp:1115] HTTP POST for /slave(1251)/api/v1 from 172.17.0.2:33016
I1011 17:32:11.122645 18982 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'
I1011 17:32:11.125942   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/GetPluginInfo call
I1011 17:32:11.126439   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Identity/GetPluginInfo call
I1011 17:32:11.128916 18989 v1_volume_manager.cpp:649] NODE_SERVICE loaded: {}
I1011 17:32:11.129825 18989 v1_volume_manager.cpp:649] CONTROLLER_SERVICE loaded: {}
I1011 17:32:11.132530 18966 hierarchical.cpp:1843] Performed allocation for 1 agents in 322181ns
I1011 17:32:11.132961   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ControllerGetCapabilities call
I1011 17:32:11.138432   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Node/NodeGetCapabilities call
I1011 17:32:11.143299   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Node/NodeGetInfo call
I1011 17:32:11.146739 18971 provider.cpp:676] Recovered resources '{}' and 0 operations for resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test'
I1011 17:32:11.146994 18970 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:11.147433 18984 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.151978 18980 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.152777 18988 provider.cpp:476] Connected to resource provider manager
I1011 17:32:11.153661 18976 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.155076 18983 process.cpp:3671] Handling HTTP event for process 'slave(1251)' with path: '/slave(1251)/api/v1/resource_provider'
I1011 17:32:11.157361 18970 http.cpp:1115] HTTP POST for /slave(1251)/api/v1/resource_provider from 172.17.0.2:33020
I1011 17:32:11.158418 18971 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_hzIGBZ","--available_capacity=0B","--volumes=","--forward=unix:///tmp/Yv6fnA/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"}
I1011 17:32:11.184198 18978 hierarchical.cpp:1843] Performed allocation for 1 agents in 254068ns
I1011 17:32:11.212321 18985 slave.cpp:8483] Handling resource provider message 'SUBSCRIBE: {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"ea5b3114-355b-49e7-b095-eaecec78d698"},"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_hzIGBZ","--available_capacity=0B","--volumes=","--forward=unix:///tmp/Yv6fnA/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"}'
I1011 17:32:11.214911 18967 provider.cpp:498] Received SUBSCRIBED event
I1011 17:32:11.214994 18967 provider.cpp:1309] Subscribed with ID ea5b3114-355b-49e7-b095-eaecec78d698
I1011 17:32:11.216336 18974 status_update_manager_process.hpp:314] Recovering operation status update manager
I1011 17:32:11.235296 18977 hierarchical.cpp:1843] Performed allocation for 1 agents in 288216ns
I1011 17:32:11.286733 18984 hierarchical.cpp:1843] Performed allocation for 1 agents in 190493ns
I1011 17:32:11.320466 18970 provider.cpp:790] Reconciling storage pools and volumes
I1011 17:32:11.323714   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call
I1011 17:32:11.327795 18972 provider.cpp:2217] Sending UPDATE_STATE call with resources '{}' and 0 operations to agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0
I1011 17:32:11.328336 18974 http_connection.hpp:131] Sending UPDATE_STATE call to http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.328541 18972 provider.cpp:748] Resource provider ea5b3114-355b-49e7-b095-eaecec78d698 is in READY state
I1011 17:32:11.328685 18971 status_update_manager_process.hpp:385] Resuming operation status update manager
I1011 17:32:11.329931 18969 provider.cpp:1235] Updating profiles { test } for resource provider ea5b3114-355b-49e7-b095-eaecec78d698
I1011 17:32:11.330431 18970 process.cpp:3671] Handling HTTP event for process 'slave(1251)' with path: '/slave(1251)/api/v1/resource_provider'
I1011 17:32:11.331753 18980 provider.cpp:790] Reconciling storage pools and volumes
I1011 17:32:11.333564 18971 http.cpp:1115] HTTP POST for /slave(1251)/api/v1/resource_provider from 172.17.0.2:33018
I1011 17:32:11.334411 18972 manager.cpp:1045] Received UPDATE_STATE call with resources '[]' and 0 operations from resource provider ea5b3114-355b-49e7-b095-eaecec78d698
I1011 17:32:11.334790 18987 slave.cpp:8483] Handling resource provider message 'UPDATE_STATE: ea5b3114-355b-49e7-b095-eaecec78d698 {}'
I1011 17:32:11.334988 18987 slave.cpp:8603] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1011 17:32:11.335121   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call
I1011 17:32:11.336277   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/GetCapacity call
I1011 17:32:11.337463 18988 hierarchical.cpp:1100] Grew agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 by {} (total), {  } (used)
I1011 17:32:11.338096 18988 hierarchical.cpp:1057] Agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 (5a7f1e158b5b) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I1011 17:32:11.338791 18988 hierarchical.cpp:1843] Performed allocation for 1 agents in 273424ns
I1011 17:32:11.342232 18985 hierarchical.cpp:1843] Performed allocation for 1 agents in 217815ns
I1011 17:32:11.342748 18970 provider.cpp:790] Reconciling storage pools and volumes
I1011 17:32:11.345347   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/ListVolumes call
I1011 17:32:11.345777   858 test_csi_plugin.cpp:1915] Forwarding /csi.v1.Controller/GetCapacity call
I1011 17:32:11.356351 18976 slave.cpp:924] Agent terminating
I1011 17:32:11.357450 18976 manager.cpp:163] Terminating resource provider ea5b3114-355b-49e7-b095-eaecec78d698
I1011 17:32:11.358080 18974 master.cpp:1296] Agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b) disconnected
I1011 17:32:11.358137 18974 master.cpp:3391] Disconnecting agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:11.358275 18974 master.cpp:3410] Deactivating agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 at slave(1251)@172.17.0.2:33599 (5a7f1e158b5b)
I1011 17:32:11.358598 18972 hierarchical.cpp:1146] Agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0 deactivated
E1011 17:32:11.359000 18980 http_connection.hpp:452] End-Of-File received
I1011 17:32:11.359724 18980 http_connection.hpp:217] Re-detecting endpoint
I1011 17:32:11.360488 18980 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I1011 17:32:11.360610 18980 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I1011 17:32:11.360652 18985 provider.cpp:488] Disconnected from resource provider manager
I1011 17:32:11.360743 18980 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.360844 18985 status_update_manager_process.hpp:379] Pausing operation status update manager
I1011 17:32:11.363013 18969 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
I1011 17:32:11.363124 18969 containerizer.cpp:3318] 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 15.755364352secs
I1011 17:32:11.363829 18969 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:11.365866 18979 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.366962 18967 provider.cpp:476] Connected to resource provider manager
I1011 17:32:11.367866 18988 http_connection.hpp:131] Sending SUBSCRIBE call to http://172.17.0.2:33599/slave(1251)/api/v1/resource_provider
I1011 17:32:11.369103 18990 process.cpp:2781] Returning '404 Not Found' for '/slave(1251)/api/v1/resource_provider'
E1011 17:32:11.371021 18975 provider.cpp:721] Failed to subscribe resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test': Received '404 Not Found' ()
I1011 17:32:11.391058 18984 hierarchical.cpp:1843] Performed allocation for 1 agents in 211886ns
I1011 17:32:11.439502 18981 containerizer.cpp:3156] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE has exited
I1011 17:32:11.441716 18979 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
I1011 17:32:11.442744 18977 hierarchical.cpp:1843] Performed allocation for 1 agents in 190417ns
I1011 17:32:11.445034 18984 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'
I1011 17:32:11.445392 18972 service_manager.cpp:723] Disconnected from endpoint 'unix:///tmp/mesos-csi-nRn3fR/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I1011 17:32:11.445755 18974 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I1011 17:32:11.449635 18990 process.cpp:2781] Returning '404 Not Found' for '/slave(1251)/api/v1'
I1011 17:32:11.465093 18972 master.cpp:1137] Master terminating
I1011 17:32:11.465945 18974 hierarchical.cpp:1122] Removed all filters for agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0
I1011 17:32:11.465992 18974 hierarchical.cpp:998] Removed agent b23420ec-e0a8-4c91-9555-c1493e416b6c-S0
[       OK ] CSIVersion/StorageLocalResourceProviderTest.Update/v1 (1017 ms)
[----------] 54 tests from CSIVersion/StorageLocalResourceProviderTest (128122 ms total)

[----------] Global test environment tear-down
[==========] 2323 tests from 222 test cases ran. (1397464 ms total)
[  PASSED  ] 2322 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ] ProvisionerDockerLocalStoreTest.PullingSameImageSimutanuously

 1 FAILED TEST
  YOU HAVE 32 DISABLED TESTS

I1011 17:32:11.629155 18990 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-1570805047-13486
Untagged: mesos-1570805047-13486:latest
Deleted: sha256:a1354dd12acd5e546e429b57259d61c1829cbd0ff7b0e85ef93b892e55c2270c
Deleted: sha256:fe7afb3ae824583240b0de79058bf402a9884b9d2ce141f5186850dc16c1d3a0
Deleted: sha256:46ec70f7609261ebcf2181a536390448383f64afd0ff890cc4d5ed95dd23568c
Deleted: sha256:fccaebab4e5f8de254403ae38607bd3a464de986788d15ed73e83b5292260fef
Deleted: sha256:45f4ab7baab38be973b4e276dcf3ee5c8e5844a07c69bad37cdf67a399ca07e3
Deleted: sha256:6107664677f7c6603a8e0680a1560c2b117e48a3c72f109156e9cb384facda69
Deleted: sha256:798a46ad24da1acec72e73d354d79cf5aa778634c286b866f6a2d71b0d7ea5b9
Deleted: sha256:42a82a2ff3b7d00524066bdefdd5c69b2ed1f602927106644f22c50a594da18d
Deleted: sha256:a084048b9861521119162fd4aba4c1c45f0e3134d5cd246df5cb0ca0497e2f96
Deleted: sha256:c599516daab7b195702401e4e6dfb5369b0b991159edbd76c358b5750851157c
Deleted: sha256:713c2458bea99976140897e062026cdbb3bff4bda92182d0a9dd0444ae2bd39c
Deleted: sha256:eb72aef6fb61ed355e483a0d8e2eb07222095753603c152aee3e32712fae574f
Deleted: sha256:0c194f783353397c001e085d49103b91903799150517f9f74ea10171b9b2b457
Deleted: sha256:23185cf846395381d7cd9108476a166029081c36142db03249afce379aae8da5
Deleted: sha256:2fe451dc9d5a19fba44b70fbd82089f7cfa003d58ecd3df6b527be734f6cd882
Deleted: sha256:2af6f8a596f324ab821fc8717932c240efe87a1a0f5d4a6b136e6c397f710756
Deleted: sha256:2a0be28ceb820ee935eb0a50dec2f919bfc7c9b6869783c79a13c0d00d997386
Deleted: sha256:dd809bfb9ac1b4395dc22505254e6f52aab1c181c2d24c8ad924b08c05778ec6
Deleted: sha256:1568a93eabdcfb07d6153848d1d2ec02d29caab9510da0bcc6c7c2bfd739b54f
Deleted: sha256:2d6e7715b881b127468f7ad06b4abd14c5f8cd6e5f1358db8dce8f23e0520eba
Deleted: sha256:20339da0540ae75595dc400602b5f970eeb14263cb4aa30bb129078e85912de0
Deleted: sha256:58b32e87f9cdfbd55feec5ce54a1c795fa8745bdae5e2be4b6e6fe9493454423
Deleted: sha256:2eb366a043b8e56a9c70f2f3f688cc72613c12b7dbed06fc980350b0841ec586
Deleted: sha256:22270a439a6d24fc30120bd53de71539b91b6c9a98354721b4e51c47f234e717
Deleted: sha256:be1af20a95511d224202e72539ad4e5999141e64d37619864ff68a4522a46299
Deleted: sha256:89725f78f37625479f28481cd66bd686da3736c95eda5dc1782f3c354b24b1f6
Deleted: sha256:0b95f38253fe68f1f4d8d5b4a0dd94a6a2b090d1bf40c2c84d572bd22089ec6c
Deleted: sha256:278d1ee546d5fca8dc42104e976cf6ce78654793dc95918aca399ef540b5ca05
Deleted: sha256:486ba9e45eea6bdb4a3686ad68a564036446e6195fe91348e215182cffb98f8d
Deleted: sha256:0819b6aee69fc36fba4af7c63601dacfd480e1ec333cb5427e1ffb95b76d5b96

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

- Mesos Reviewbot


On Oct. 11, 2019, 7:09 a.m., Qian Zhang wrote:
> 
> -----------------------------------------------------------
> This is an automatically generated e-mail. To reply, visit:
> https://reviews.apache.org/r/71608/
> -----------------------------------------------------------
> 
> (Updated Oct. 11, 2019, 7:09 a.m.)
> 
> 
> Review request for mesos and Gilbert Song.
> 
> 
> Bugs: MESOS-9964
>     https://issues.apache.org/jira/browse/MESOS-9964
> 
> 
> Repository: mesos
> 
> 
> Description
> -------
> 
> WIP: Supported destroying UCR container in `PROVISIONING` state.
> 
> 
> Diffs
> -----
> 
>   src/slave/containerizer/mesos/containerizer.cpp c61b954635ebcaed3e498452bddeee6e1b34f388 
>   src/slave/containerizer/mesos/provisioner/docker/store.cpp 286ee5f00933b4c86a96dc4e10e42f9e7eac0ce2 
> 
> 
> Diff: https://reviews.apache.org/r/71608/diff/1/
> 
> 
> Testing
> -------
> 
> 
> Thanks,
> 
> Qian Zhang
> 
>


Mime
  • Unnamed multipart/alternative (inline, None, 0 bytes)
View raw message