-----------------------------------------------------------
This is an automatically generated e-mail. To reply, visit:
https://reviews.apache.org/r/71518/#review217854
-----------------------------------------------------------
Bad patch!
Reviews applied: [71501, 71518]
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_71518"]
Error:
...<truncated>...
located: 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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,test)]:2048,
offered or allocated: {}) on agent 36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
from framework 36c92ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:25.709256 18652 hierarchical.cpp:1558] Framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 filtered agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 for 5secs
I0919 14:44:25.711563 18634 master.cpp:12557] Sending operation '' (uuid:
6ff76f8a-681e-4043-b580-a52aa2c6d2c7) to agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 at slave(1248)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:25.712173 18650 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:25.715298 18639 provider.cpp:498] Received APPLY_OPERATION event
I0919 14:44:25.715380 18639 provider.cpp:1351] Received CREATE operation ''
(uuid: 6ff76f8a-681e-4043-b580-a52aa2c6d2c7)
I0919 14:44:25.721730 18638 master.cpp:6398] Processing REVIVE call for
framework 36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:25.722220 18631 hierarchical.cpp:1654] Unsuppressed offers and
cleared filters for roles { storage/default-role } of framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:25.723402 18631 hierarchical.cpp:1786] Performed allocation for 1
agents in 996549ns
I0919 14:44:25.723737 18631 hierarchical.cpp:1786] Performed allocation for 1
agents in 145181ns
I0919 14:44:25.724021 18637 master.cpp:10389] Sending offers [
36c92ce8-38aa-4a77-a380-06d69b1beebc-O4 ] to framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:25.724589 18648 sched.cpp:934] Scheduler::resourceOffers took
76312ns
I0919 14:44:25.732537 18654 http.cpp:1115] HTTP POST for
/slave(1248)/api/v1/resource_provider from 172.17.0.3:55102
I0919 14:44:25.733646 18650 slave.cpp:8482] Handling resource provider message
'UPDATE_OPERATION_STATUS: (uuid: 18778154-fd20-4e09-ada8-d19502ac05ca) for
framework (latest state: OPERATION_FINISHED, status update state:
OPERATION_FINISHED)'
I0919 14:44:25.733819 18650 slave.cpp:8935] Updating the state of operation
with no ID (uuid: 18778154-fd20-4e09-ada8-d19502ac05ca) for an operation API
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0919 14:44:25.733873 18650 slave.cpp:8689] Forwarding status update of
operation with no ID (operation_uuid: 18778154-fd20-4e09-ada8-d19502ac05ca) for
an operator API call
I0919 14:44:25.734203 18632 master.cpp:12213] Updating the state of operation
'' (uuid: 18778154-fd20-4e09-ada8-d19502ac05ca) for an operator API call
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0919 14:44:25.734715 18651 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:25.802605 18648 status_update_manager_process.hpp:152] Received
operation status update OPERATION_FINISHED (Status UUID:
80541db7-67e3-4040-89d6-cc2d45370739) for operation UUID
6ff76f8a-681e-4043-b580-a52aa2c6d2c7 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:25.802673 18648 status_update_manager_process.hpp:414] Creating
operation status update stream 6ff76f8a-681e-4043-b580-a52aa2c6d2c7
checkpoint=true
I0919 14:44:25.802695 18639 provider.cpp:498] Received
ACKNOWLEDGE_OPERATION_STATUS event
I0919 14:44:25.802994 18648 status_update_manager_process.hpp:929]
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status
UUID: 80541db7-67e3-4040-89d6-cc2d45370739) for operation UUID
6ff76f8a-681e-4043-b580-a52aa2c6d2c7 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:25.852852 18648 status_update_manager_process.hpp:528] Forwarding
operation status update OPERATION_FINISHED (Status UUID:
80541db7-67e3-4040-89d6-cc2d45370739) for operation UUID
6ff76f8a-681e-4043-b580-a52aa2c6d2c7 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:25.853178 18648 status_update_manager_process.hpp:252] Received
operation status update acknowledgement (UUID:
42e27eca-3624-4512-a0a3-09a70a8ab3f0) for stream
18778154-fd20-4e09-ada8-d19502ac05ca
I0919 14:44:25.853247 18648 status_update_manager_process.hpp:929]
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID:
42e27eca-3624-4512-a0a3-09a70a8ab3f0) for operation UUID
18778154-fd20-4e09-ada8-d19502ac05ca on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:25.853668 18652 http_connection.hpp:131] Sending
UPDATE_OPERATION_STATUS call to
http://172.17.0.3:44477/slave(1248)/api/v1/resource_provider
I0919 14:44:25.854549 18653 process.cpp:3671] Handling HTTP event for process
'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider'
I0919 14:44:25.892266 18645 http.cpp:1115] HTTP POST for
/slave(1248)/api/v1/resource_provider from 172.17.0.3:55102
I0919 14:44:25.893260 18640 slave.cpp:8482] Handling resource provider message
'UPDATE_OPERATION_STATUS: (uuid: 6ff76f8a-681e-4043-b580-a52aa2c6d2c7) for
framework (latest state: OPERATION_FINISHED, status update state:
OPERATION_FINISHED)'
I0919 14:44:25.893445 18640 slave.cpp:8935] Updating the state of operation
with no ID (uuid: 6ff76f8a-681e-4043-b580-a52aa2c6d2c7) for an operation API
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0919 14:44:25.893496 18640 slave.cpp:8689] Forwarding status update of
operation with no ID (operation_uuid: 6ff76f8a-681e-4043-b580-a52aa2c6d2c7) for
an operator API call
I0919 14:44:25.893831 18651 master.cpp:12213] Updating the state of operation
'' (uuid: 6ff76f8a-681e-4043-b580-a52aa2c6d2c7) for an operator API call
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0919 14:44:25.894309 18641 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:25.895658 18634 provider.cpp:498] Received
ACKNOWLEDGE_OPERATION_STATUS event
I0919 14:44:25.902987 18648 status_update_manager_process.hpp:490] Cleaning up
operation status update stream 18778154-fd20-4e09-ada8-d19502ac05ca
I0919 14:44:25.903216 18648 status_update_manager_process.hpp:252] Received
operation status update acknowledgement (UUID:
80541db7-67e3-4040-89d6-cc2d45370739) for stream
6ff76f8a-681e-4043-b580-a52aa2c6d2c7
I0919 14:44:25.903300 18648 status_update_manager_process.hpp:929]
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID:
80541db7-67e3-4040-89d6-cc2d45370739) for operation UUID
6ff76f8a-681e-4043-b580-a52aa2c6d2c7 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:25.986865 18648 status_update_manager_process.hpp:490] Cleaning up
operation status update stream 6ff76f8a-681e-4043-b580-a52aa2c6d2c7
I0919 14:44:26.048811 18650 process.cpp:3671] Handling HTTP event for process
'master' with path: '/master/api/v1'
I0919 14:44:26.050391 18644 http.cpp:1115] HTTP POST for /master/api/v1 from
172.17.0.3:55110
I0919 14:44:26.050628 18644 http.cpp:263] Processing call DESTROY_VOLUMES
I0919 14:44:26.051465 18644 master.cpp:3983] Authorizing principal
'test-principal' to destroy volumes
'[{"disk":{"persistence":{"id":"3d956856-bdd2-4513-8cfc-cf775bc04ec3","principal":"test-principal"},"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317","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":"bf406a57-7987-4c6f-9e6f-0544748c5606"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I0919 14:44:26.053436 18635 sched.cpp:960] Rescinded offer
36c92ce8-38aa-4a77-a380-06d69b1beebc-O4
I0919 14:44:26.053583 18635 sched.cpp:971] Scheduler::offerRescinded took
69330ns
I0919 14:44:26.054093 18636 master.cpp:12684] Removing offer
36c92ce8-38aa-4a77-a380-06d69b1beebc-O4
I0919 14:44:26.055500 18641 hierarchical.cpp:1511] 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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,test),3d956856-bdd2-4513-8cfc-cf775bc04ec3: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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,test),3d956856-bdd2-4513-8cfc-cf775bc04ec3:volume]:2048,
offered
or allocated: {}) on agent 36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 from
framework 36c92ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:26.055613 18641 hierarchical.cpp:1558] Framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 filtered agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 for 5secs
I0919 14:44:26.058598 18637 master.cpp:12557] Sending operation '' (uuid:
58eb10f7-fc43-4e89-b55c-fe63b897c600) to agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 at slave(1248)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:26.059144 18637 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:26.062477 18640 provider.cpp:498] Received APPLY_OPERATION event
I0919 14:44:26.062517 18640 provider.cpp:1351] Received DESTROY operation ''
(uuid: 58eb10f7-fc43-4e89-b55c-fe63b897c600)
I0919 14:44:26.070030 18645 hierarchical.cpp:1786] Performed allocation for 1
agents in 1.103363ms
I0919 14:44:26.070677 18638 master.cpp:10389] Sending offers [
36c92ce8-38aa-4a77-a380-06d69b1beebc-O5 ] to framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:26.071342 18644 sched.cpp:934] Scheduler::resourceOffers took
78326ns
I0919 14:44:26.147233 18651 status_update_manager_process.hpp:152] Received
operation status update OPERATION_FINISHED (Status UUID:
792b66ba-b80f-4163-8d94-14dbb9e71673) for operation UUID
58eb10f7-fc43-4e89-b55c-fe63b897c600 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.147330 18651 status_update_manager_process.hpp:414] Creating
operation status update stream 58eb10f7-fc43-4e89-b55c-fe63b897c600
checkpoint=true
I0919 14:44:26.147842 18651 status_update_manager_process.hpp:929]
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status
UUID: 792b66ba-b80f-4163-8d94-14dbb9e71673) for operation UUID
58eb10f7-fc43-4e89-b55c-fe63b897c600 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.197268 18651 status_update_manager_process.hpp:528] Forwarding
operation status update OPERATION_FINISHED (Status UUID:
792b66ba-b80f-4163-8d94-14dbb9e71673) for operation UUID
58eb10f7-fc43-4e89-b55c-fe63b897c600 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.198565 18635 http_connection.hpp:131] Sending
UPDATE_OPERATION_STATUS call to
http://172.17.0.3:44477/slave(1248)/api/v1/resource_provider
I0919 14:44:26.199916 18641 process.cpp:3671] Handling HTTP event for process
'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider'
I0919 14:44:26.203812 18633 process.cpp:3671] Handling HTTP event for process
'master' with path: '/master/api/v1'
I0919 14:44:26.205561 18632 http.cpp:1115] HTTP POST for /master/api/v1 from
172.17.0.3:55112
I0919 14:44:26.205790 18632 http.cpp:263] Processing call UNRESERVE_RESOURCES
I0919 14:44:26.206383 18632 master.cpp:3875] Authorizing principal
'test-principal' to unreserve resources
'[{"disk":{"source":{"id":"/tmp/CSIVersion_StorageLocalResourceProviderTest_OperatorOperationsWithResourceProviderResources_v1_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317","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":"bf406a57-7987-4c6f-9e6f-0544748c5606"},"reservations":[{"role":"storage","type":"DYNAMIC"},{"principal":"test-principal","role":"storage/default-role","type":"DYNAMIC"}],"scalar":{"value":2048.0},"type":"SCALAR"}]'
I0919 14:44:26.207626 18638 sched.cpp:960] Rescinded offer
36c92ce8-38aa-4a77-a380-06d69b1beebc-O5
I0919 14:44:26.207706 18638 sched.cpp:971] Scheduler::offerRescinded took
25358ns
I0919 14:44:26.208200 18642 master.cpp:12684] Removing offer
36c92ce8-38aa-4a77-a380-06d69b1beebc-O5
I0919 14:44:26.209193 18644 hierarchical.cpp:1511] 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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,test)]:2048,
offered or allocated: {}) on agent 36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
from framework 36c92
ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:26.209296 18644 hierarchical.cpp:1558] Framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 filtered agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 for 5secs
I0919 14:44:26.211655 18640 master.cpp:12557] Sending operation '' (uuid:
bfb3a12d-09b0-4193-9947-3d77911f4d27) to agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 at slave(1248)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:26.212208 18631 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:26.215116 18648 provider.cpp:498] Received APPLY_OPERATION event
I0919 14:44:26.215157 18648 provider.cpp:1351] Received UNRESERVE operation ''
(uuid: bfb3a12d-09b0-4193-9947-3d77911f4d27)
I0919 14:44:26.223589 18654 hierarchical.cpp:1786] Performed allocation for 1
agents in 999940ns
I0919 14:44:26.224123 18632 master.cpp:10389] Sending offers [
36c92ce8-38aa-4a77-a380-06d69b1beebc-O6 ] to framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:26.224671 18632 sched.cpp:934] Scheduler::resourceOffers took
69835ns
I0919 14:44:26.240571 18635 http.cpp:1115] HTTP POST for
/slave(1248)/api/v1/resource_provider from 172.17.0.3:55102
I0919 14:44:26.241787 18646 slave.cpp:8482] Handling resource provider message
'UPDATE_OPERATION_STATUS: (uuid: 58eb10f7-fc43-4e89-b55c-fe63b897c600) for
framework (latest state: OPERATION_FINISHED, status update state:
OPERATION_FINISHED)'
I0919 14:44:26.241993 18646 slave.cpp:8935] Updating the state of operation
with no ID (uuid: 58eb10f7-fc43-4e89-b55c-fe63b897c600) for an operation API
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0919 14:44:26.242055 18646 slave.cpp:8689] Forwarding status update of
operation with no ID (operation_uuid: 58eb10f7-fc43-4e89-b55c-fe63b897c600) for
an operator API call
I0919 14:44:26.242615 18631 master.cpp:12213] Updating the state of operation
'' (uuid: 58eb10f7-fc43-4e89-b55c-fe63b897c600) for an operator API call
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0919 14:44:26.243302 18643 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:26.298393 18632 status_update_manager_process.hpp:152] Received
operation status update OPERATION_FINISHED (Status UUID:
d786361d-dd50-4e64-9eff-41754f624fb1) for operation UUID
bfb3a12d-09b0-4193-9947-3d77911f4d27 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.298463 18632 status_update_manager_process.hpp:414] Creating
operation status update stream bfb3a12d-09b0-4193-9947-3d77911f4d27
checkpoint=true
I0919 14:44:26.298485 18648 provider.cpp:498] Received
ACKNOWLEDGE_OPERATION_STATUS event
I0919 14:44:26.298799 18632 status_update_manager_process.hpp:929]
Checkpointing UPDATE for operation status update OPERATION_FINISHED (Status
UUID: d786361d-dd50-4e64-9eff-41754f624fb1) for operation UUID
bfb3a12d-09b0-4193-9947-3d77911f4d27 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.348534 18632 status_update_manager_process.hpp:528] Forwarding
operation status update OPERATION_FINISHED (Status UUID:
d786361d-dd50-4e64-9eff-41754f624fb1) for operation UUID
bfb3a12d-09b0-4193-9947-3d77911f4d27 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.348944 18632 status_update_manager_process.hpp:252] Received
operation status update acknowledgement (UUID:
792b66ba-b80f-4163-8d94-14dbb9e71673) for stream
58eb10f7-fc43-4e89-b55c-fe63b897c600
I0919 14:44:26.349064 18632 status_update_manager_process.hpp:929]
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID:
792b66ba-b80f-4163-8d94-14dbb9e71673) for operation UUID
58eb10f7-fc43-4e89-b55c-fe63b897c600 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.349714 18638 http_connection.hpp:131] Sending
UPDATE_OPERATION_STATUS call to
http://172.17.0.3:44477/slave(1248)/api/v1/resource_provider
I0919 14:44:26.351007 18644 process.cpp:3671] Handling HTTP event for process
'slave(1248)' with path: '/slave(1248)/api/v1/resource_provider'
I0919 14:44:26.388839 18631 http.cpp:1115] HTTP POST for
/slave(1248)/api/v1/resource_provider from 172.17.0.3:55102
I0919 14:44:26.390022 18639 slave.cpp:8482] Handling resource provider message
'UPDATE_OPERATION_STATUS: (uuid: bfb3a12d-09b0-4193-9947-3d77911f4d27) for
framework (latest state: OPERATION_FINISHED, status update state:
OPERATION_FINISHED)'
I0919 14:44:26.390213 18639 slave.cpp:8935] Updating the state of operation
with no ID (uuid: bfb3a12d-09b0-4193-9947-3d77911f4d27) for an operation API
call (latest state: OPERATION_FINISHED, status update state: OPERATION_FINISHED)
I0919 14:44:26.390262 18639 slave.cpp:8689] Forwarding status update of
operation with no ID (operation_uuid: bfb3a12d-09b0-4193-9947-3d77911f4d27) for
an operator API call
I0919 14:44:26.390635 18643 master.cpp:12213] Updating the state of operation
'' (uuid: bfb3a12d-09b0-4193-9947-3d77911f4d27) for an operator API call
(latest state: OPERATION_PENDING, status update state: OPERATION_FINISHED)
I0919 14:44:26.391238 18637 slave.cpp:4352] Ignoring new checkpointed resources
and operations identical to the current version
I0919 14:44:26.392660 18651 provider.cpp:498] Received
ACKNOWLEDGE_OPERATION_STATUS event
I0919 14:44:26.398686 18632 status_update_manager_process.hpp:490] Cleaning up
operation status update stream 58eb10f7-fc43-4e89-b55c-fe63b897c600
I0919 14:44:26.398962 18632 status_update_manager_process.hpp:252] Received
operation status update acknowledgement (UUID:
d786361d-dd50-4e64-9eff-41754f624fb1) for stream
bfb3a12d-09b0-4193-9947-3d77911f4d27
I0919 14:44:26.399051 18632 status_update_manager_process.hpp:929]
Checkpointing ACK for operation status update OPERATION_FINISHED (Status UUID:
d786361d-dd50-4e64-9eff-41754f624fb1) for operation UUID
bfb3a12d-09b0-4193-9947-3d77911f4d27 on agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.465880 18632 status_update_manager_process.hpp:490] Cleaning up
operation status update stream bfb3a12d-09b0-4193-9947-3d77911f4d27
I0919 14:44:26.526175 18636 master.cpp:1411] Framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477 disconnected
I0919 14:44:26.526252 18636 master.cpp:3356] Deactivating framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:26.526715 18631 hierarchical.cpp:769] Deactivated framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:26.527622 18630 slave.cpp:924] Agent terminating
I0919 14:44:26.527662 18636 master.cpp:12684] Removing offer
36c92ce8-38aa-4a77-a380-06d69b1beebc-O6
I0919 14:44:26.527765 18636 master.cpp:3333] Disconnecting framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:26.527840 18636 master.cpp:1426] Giving framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477 0ns to failover
I0919 14:44:26.528599 18630 manager.cpp:163] Terminating resource provider
bf406a57-7987-4c6f-9e6f-0544748c5606
I0919 14:44:26.528853 18631 hierarchical.cpp:1511] 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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,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_zHLLLc/2GB-c042af93-66e7-4215-af26-72013ff85317,test)]:2048,
offered or allocated: {}) on agent 36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
from framework 36c92ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:26.529147 18635 master.cpp:10181] Framework failover timeout,
removing framework 36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
I0919 14:44:26.529196 18635 master.cpp:11177] Removing framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000 (default) at
[email protected]:44477
E0919 14:44:26.529584 18641 http_connection.hpp:452] End-Of-File received
I0919 14:44:26.529630 18639 hierarchical.cpp:1710] Allocation paused
I0919 14:44:26.529723 18635 master.cpp:1296] Agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 at slave(1248)@172.17.0.3:44477
(1b384509bb52) disconnected
I0919 14:44:26.529754 18635 master.cpp:3391] Disconnecting agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 at slave(1248)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:26.529834 18635 master.cpp:3410] Deactivating agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 at slave(1248)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:26.530092 18641 http_connection.hpp:217] Re-detecting endpoint
I0919 14:44:26.530133 18639 hierarchical.cpp:713] Removed framework
36c92ce8-38aa-4a77-a380-06d69b1beebc-0000
I0919 14:44:26.530210 18639 hierarchical.cpp:1720] Allocation resumed
I0919 14:44:26.530326 18639 hierarchical.cpp:1096] Agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0 deactivated
I0919 14:44:26.530583 18641 http_connection.hpp:338] Ignoring disconnection
attempt from stale connection
I0919 14:44:26.530658 18638 provider.cpp:488] Disconnected from resource
provider manager
I0919 14:44:26.530691 18641 http_connection.hpp:338] Ignoring disconnection
attempt from stale connection
I0919 14:44:26.530803 18642 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:26.530820 18641 http_connection.hpp:227] New endpoint detected at
http://172.17.0.3:44477/slave(1248)/api/v1/resource_provider
I0919 14:44:26.532312 18651 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
I0919 14:44:26.532367 18651 containerizer.cpp:3327] 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 2.29581504secs
I0919 14:44:26.532838 18651 launcher.cpp:161] Asked to destroy container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:26.534265 18650 hierarchical.cpp:1786] Performed allocation for 1
agents in 187166ns
I0919 14:44:26.534550 18635 http_connection.hpp:283] Connected with the remote
endpoint at http://172.17.0.3:44477/slave(1248)/api/v1/resource_provider
I0919 14:44:26.535102 18642 provider.cpp:476] Connected to resource provider
manager
I0919 14:44:26.535759 18645 http_connection.hpp:131] Sending SUBSCRIBE call to
http://172.17.0.3:44477/slave(1248)/api/v1/resource_provider
I0919 14:44:26.536645 18655 process.cpp:2781] Returning '404 Not Found' for
'/slave(1248)/api/v1/resource_provider'
E0919 14:44:26.537883 18640 provider.cpp:721] Failed to subscribe resource
provider with type 'org.apache.mesos.rp.local.storage' and name 'test':
Received '404 Not Found' ()
I0919 14:44:26.585683 18634 hierarchical.cpp:1786] Performed allocation for 1
agents in 177615ns
I0919 14:44:26.636166 18654 containerizer.cpp:3165] Container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
has exited
I0919 14:44:26.637389 18633 hierarchical.cpp:1786] Performed allocation for 1
agents in 146090ns
I0919 14:44:26.637917 18636 provisioner.cpp:612] Ignoring destroy request for
unknown container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:26.641865 18653 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'
I0919 14:44:26.642192 18643 service_manager.cpp:723] Disconnected from endpoint
'unix:///tmp/mesos-csi-2BJSJY/endpoint.sock' of CSI plugin container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:26.642529 18652 container_daemon.cpp:121] Launching container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:26.646939 18655 process.cpp:2781] Returning '404 Not Found' for
'/slave(1248)/api/v1'
I0919 14:44:26.658989 18648 master.cpp:1137] Master terminating
I0919 14:44:26.659855 18654 hierarchical.cpp:1072] Removed all filters for
agent 36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
I0919 14:44:26.659886 18654 hierarchical.cpp:949] Removed agent
36c92ce8-38aa-4a77-a380-06d69b1beebc-S0
[ OK ]
CSIVersion/StorageLocalResourceProviderTest.OperatorOperationsWithResourceProviderResources/v1
(2184 ms)
[ RUN ] CSIVersion/StorageLocalResourceProviderTest.Update/v0
I0919 14:44:26.678150 18630 cluster.cpp:177] Creating default 'local' authorizer
I0919 14:44:26.684671 18650 master.cpp:440] Master
aa4f9b23-ab02-4791-a49d-b165a668a288 (1b384509bb52) started on 172.17.0.3:44477
I0919 14:44:26.684710 18650 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/YTBE9G/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/YTBE9G/master" --zk_session_timeout="10secs"
I0919 14:44:26.685180 18650 master.cpp:492] Master only allowing authenticated
frameworks to register
I0919 14:44:26.685199 18650 master.cpp:498] Master only allowing authenticated
agents to register
I0919 14:44:26.685210 18650 master.cpp:504] Master only allowing authenticated
HTTP frameworks to register
I0919 14:44:26.685222 18650 credentials.hpp:37] Loading credentials for
authentication from '/tmp/YTBE9G/credentials'
I0919 14:44:26.685624 18650 master.cpp:548] Using default 'crammd5'
authenticator
I0919 14:44:26.685883 18650 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I0919 14:44:26.686146 18650 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I0919 14:44:26.686383 18650 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I0919 14:44:26.686571 18650 master.cpp:629] Authorization enabled
I0919 14:44:26.687052 18640 whitelist_watcher.cpp:77] No whitelist given
I0919 14:44:26.687078 18643 hierarchical.cpp:532] Initialized hierarchical
allocator process
I0919 14:44:26.690862 18646 master.cpp:2169] Elected as the leading master!
I0919 14:44:26.690901 18646 master.cpp:1665] Recovering from registrar
I0919 14:44:26.691099 18654 registrar.cpp:339] Recovering registrar
I0919 14:44:26.692019 18654 registrar.cpp:383] Successfully fetched the
registry (0B) in 0ns
I0919 14:44:26.692170 18654 registrar.cpp:487] Applied 1 operations in 44339ns;
attempting to update the registry
I0919 14:44:26.692886 18654 registrar.cpp:544] Successfully updated the
registry in 0ns
I0919 14:44:26.693034 18654 registrar.cpp:416] Successfully recovered registrar
I0919 14:44:26.693600 18635 master.cpp:1818] Recovered 0 agents from the
registry (144B); allowing 10mins for agents to reregister
I0919 14:44:26.693645 18652 hierarchical.cpp:571] Skipping recovery of
hierarchical allocator: nothing to recover
W0919 14:44:26.700325 18630 process.cpp:2877] Attempted to spawn already
running process [email protected]:44477
I0919 14:44:26.701741 18630 containerizer.cpp:318] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0919 14:44:26.702348 18630 backend.cpp:76] Failed to create 'overlay' backend:
OverlayBackend requires root privileges
W0919 14:44:26.702379 18630 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
W0919 14:44:26.702538 18630 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
I0919 14:44:26.702581 18630 provisioner.cpp:300] Using default backend 'copy'
I0919 14:44:26.705369 18630 cluster.cpp:518] Creating default 'local' authorizer
I0919 14:44:26.708032 18634 slave.cpp:267] Mesos agent started on
(1249)@172.17.0.3:44477
I0919 14:44:26.708065 18634 slave.cpp:268] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/tmp/YTBE9G/mABZL1/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/YTBE9G/mABZL1/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/YTBE9G/mABZL1/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/YTBE9G/mABZL1/fetch" --fetcher_cache_size="2GB"
--fetcher_stall_timeout="1mins"
--frameworks_home="/tmp/YTBE9G/mABZL1/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/YTBE9G/mABZL1/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/YTBE9G/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_GT6w6G"
--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_i0g5qm"
--zk_sessio
n_timeout="10secs"
I0919 14:44:26.708624 18634 credentials.hpp:86] Loading credential for
authentication from '/tmp/YTBE9G/mABZL1/credential'
I0919 14:44:26.708806 18634 slave.cpp:300] Agent using credential for:
test-principal
I0919 14:44:26.708833 18634 credentials.hpp:37] Loading credentials for
authentication from '/tmp/YTBE9G/mABZL1/http_credentials'
I0919 14:44:26.709020 18634 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I0919 14:44:26.709358 18634 disk_profile_adaptor.cpp:82] Creating disk profile
adaptor module 'org_apache_mesos_UriDiskProfileAdaptor'
I0919 14:44:26.711020 18650 uri_disk_profile_adaptor.cpp:305] Updated disk
profile mapping to 1 active profiles
I0919 14:44:26.711042 18634 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"}]
I0919 14:44:26.711267 18634 slave.cpp:623] Agent attributes: [ ]
I0919 14:44:26.711287 18634 slave.cpp:632] Agent hostname: 1b384509bb52
I0919 14:44:26.711483 18646 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:26.711539 18644 task_status_update_manager.cpp:181] Pausing sending
task status updates
I0919 14:44:26.713171 18645 state.cpp:67] Recovering state from
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_i0g5qm/meta'
I0919 14:44:26.713423 18632 slave.cpp:7492] Finished recovering checkpointed
state from
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_i0g5qm/meta',
beginning agent recovery
I0919 14:44:26.714071 18637 task_status_update_manager.cpp:207] Recovering task
status update manager
I0919 14:44:26.714354 18647 hierarchical.cpp:1786] Performed allocation for 0
agents in 125669ns
I0919 14:44:26.714504 18652 containerizer.cpp:821] Recovering Mesos containers
I0919 14:44:26.714939 18652 containerizer.cpp:1161] Recovering isolators
I0919 14:44:26.715859 18646 containerizer.cpp:1200] Recovering provisioner
I0919 14:44:26.716621 18648 provisioner.cpp:500] Provisioner recovery complete
I0919 14:44:26.717372 18633 composing.cpp:339] Finished recovering all
containerizers
I0919 14:44:26.717646 18654 slave.cpp:7973] Recovering executors
I0919 14:44:26.717759 18654 slave.cpp:8126] Finished recovery
I0919 14:44:26.718577 18653 task_status_update_manager.cpp:181] Pausing sending
task status updates
I0919 14:44:26.718592 18643 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:26.718616 18654 slave.cpp:1351] New master detected at
[email protected]:44477
I0919 14:44:26.718739 18654 slave.cpp:1416] Detecting new master
I0919 14:44:26.726011 18638 slave.cpp:1443] Authenticating with master
[email protected]:44477
I0919 14:44:26.726101 18638 slave.cpp:1452] Using default CRAM-MD5 authenticatee
I0919 14:44:26.726415 18652 authenticatee.cpp:121] Creating new client SASL
connection
I0919 14:44:26.726753 18644 master.cpp:10574] Authenticating
slave(1249)@172.17.0.3:44477
I0919 14:44:26.726924 18650 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(2108)@172.17.0.3:44477
I0919 14:44:26.727250 18646 authenticator.cpp:98] Creating new server SASL
connection
I0919 14:44:26.727476 18641 authenticatee.cpp:213] Received SASL authentication
mechanisms: CRAM-MD5
I0919 14:44:26.727510 18641 authenticatee.cpp:239] Attempting to authenticate
with mechanism 'CRAM-MD5'
I0919 14:44:26.727632 18648 authenticator.cpp:204] Received SASL authentication
start
I0919 14:44:26.727715 18648 authenticator.cpp:326] Authentication requires more
steps
I0919 14:44:26.727859 18649 authenticatee.cpp:259] Received SASL authentication
step
I0919 14:44:26.727988 18634 authenticator.cpp:232] Received SASL authentication
step
I0919 14:44:26.728031 18634 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '1b384509bb52' server FQDN: '1b384509bb52'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
I0919 14:44:26.728055 18634 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
I0919 14:44:26.728101 18634 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
I0919 14:44:26.728138 18634 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '1b384509bb52' server FQDN: '1b384509bb52'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
I0919 14:44:26.728168 18634 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I0919 14:44:26.728185 18634 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0919 14:44:26.728211 18634 authenticator.cpp:318] Authentication success
I0919 14:44:26.728309 18632 authenticatee.cpp:299] Authentication success
I0919 14:44:26.728458 18637 master.cpp:10606] Successfully authenticated
principal 'test-principal' at slave(1249)@172.17.0.3:44477
I0919 14:44:26.728503 18645 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(2108)@172.17.0.3:44477
I0919 14:44:26.728713 18639 slave.cpp:1543] Successfully authenticated with
master [email protected]:44477
I0919 14:44:26.729105 18639 slave.cpp:1993] Will retry registration in
5.483642ms if necessary
I0919 14:44:26.729260 18640 master.cpp:7069] Received register agent message
from slave(1249)@172.17.0.3:44477 (1b384509bb52)
I0919 14:44:26.729562 18640 master.cpp:4189] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0919 14:44:26.730204 18654 master.cpp:7136] Authorized registration of agent
at slave(1249)@172.17.0.3:44477 (1b384509bb52)
I0919 14:44:26.730311 18654 master.cpp:7248] Registering agent at
slave(1249)@172.17.0.3:44477 (1b384509bb52) with id
aa4f9b23-ab02-4791-a49d-b165a668a288-S0
I0919 14:44:26.731004 18638 registrar.cpp:487] Applied 1 operations in
200542ns; attempting to update the registry
I0919 14:44:26.731724 18638 registrar.cpp:544] Successfully updated the
registry in 650752ns
I0919 14:44:26.731905 18646 master.cpp:7296] Admitted agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 at slave(1249)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:26.732653 18646 master.cpp:7341] Registered agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 at slave(1249)@172.17.0.3:44477
(1b384509bb52) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0919 14:44:26.732705 18648 slave.cpp:1576] Registered with master
[email protected]:44477; given agent ID aa4f9b23-ab02-4791-a49d-b165a668a288-S0
I0919 14:44:26.732784 18649 hierarchical.cpp:912] Added agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 (1b384509bb52) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (offered or allocated: {})
I0919 14:44:26.732815 18637 task_status_update_manager.cpp:188] Resuming
sending task status updates
I0919 14:44:26.733085 18649 hierarchical.cpp:1786] Performed allocation for 1
agents in 135510ns
I0919 14:44:26.733144 18648 slave.cpp:1611] Checkpointing SlaveInfo to
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_i0g5qm/meta/slaves/aa4f9b23-ab02-4791-a49d-b165a668a288-S0/slave.info'
I0919 14:44:26.733207 18649 status_update_manager_process.hpp:385] Resuming
operation status update manager
I0919 14:44:26.734318 18648 slave.cpp:1663] Forwarding agent update
{"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"DPXw2MyFSP20ET8OLPJS2A=="},"slave_id":{"value":"aa4f9b23-ab02-4791-a49d-b165a668a288-S0"},"update_oversubscribed_resources":false}
I0919 14:44:26.735008 18643 master.cpp:8460] Ignoring update on agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 at slave(1249)@172.17.0.3:44477
(1b384509bb52) as it reports no changes
I0919 14:44:26.739078 18641 process.cpp:3671] Handling HTTP event for process
'slave(1249)' with path: '/slave(1249)/api/v1'
I0919 14:44:26.740329 18632 http.cpp:1115] HTTP POST for /slave(1249)/api/v1
from 172.17.0.3:55120
I0919 14:44:26.740914 18632 http.cpp:2146] Processing GET_CONTAINERS call
I0919 14:44:26.746134 18651 container_daemon.cpp:121] Launching container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:26.748704 18637 process.cpp:3671] Handling HTTP event for process
'slave(1249)' with path: '/slave(1249)/api/v1'
I0919 14:44:26.749768 18645 http.cpp:1115] HTTP POST for /slave(1249)/api/v1
from 172.17.0.3:55122
I0919 14:44:26.750618 18645 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'
I0919 14:44:26.751624 18631 http.cpp:2710] Creating sandbox
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_i0g5qm/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:26.752322 18639 containerizer.cpp:1396] Starting container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:26.752948 18639 containerizer.cpp:3327] 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 228096ns
I0919 14:44:26.753698 18639 containerizer.cpp:1574] Checkpointed
ContainerConfig at
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_GT6w6G/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config'
I0919 14:44:26.753754 18639 containerizer.cpp:3327] 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 805120ns
I0919 14:44:26.757145 18638 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_M0UEL1","--available_capacity=0B","--volumes=","--forward=unix:///tmp/YTBE9G/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_i0g5qm/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-VB2zNm/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_i0g5qm/containers/org-apache-mesos-rp-local
-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}"
--pipe_read="94" --pipe_write="95"
--runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v0_GT6w6G/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"
--unshare_namespace_mnt="false"'
I0919 14:44:26.765767 18638 launcher.cpp:145] Forked child with pid '32881' for
container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:26.766798 18646 hierarchical.cpp:1786] Performed allocation for 1
agents in 318453ns
I0919 14:44:26.766881 18638 containerizer.cpp:3327] 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 13.118976ms
I0919 14:44:26.768497 18638 containerizer.cpp:3327] 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.622016ms
I0919 14:44:26.768760 18638 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_i0g5qm/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:26.769958 18653 containerizer.cpp:3327] 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 1344us
I0919 14:44:26.772773 18654 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'
I0919 14:44:26.772975 18650 service_manager.cpp:703] Connecting to endpoint
'unix:///tmp/mesos-csi-VB2zNm/endpoint.sock' of CSI plugin container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:26.818552 18635 hierarchical.cpp:1786] Performed allocation for 1
agents in 259520ns
I0919 14:44:26.870344 18643 hierarchical.cpp:1786] Performed allocation for 1
agents in 247239ns
I0919 14:44:26.921377 18639 hierarchical.cpp:1786] Performed allocation for 1
agents in 237638ns
I0919 14:44:26.972771 18646 hierarchical.cpp:1786] Performed allocation for 1
agents in 202386ns
I0919 14:44:27.024368 18645 hierarchical.cpp:1786] Performed allocation for 1
agents in 245839ns
I0919 14:44:27.075764 18631 hierarchical.cpp:1786] Performed allocation for 1
agents in 230734ns
I0919 14:44:27.127526 18651 hierarchical.cpp:1786] Performed allocation for 1
agents in 244402ns
I0919 14:44:27.163319 18634 service_manager.cpp:545] Probing endpoint
'unix:///tmp/mesos-csi-VB2zNm/endpoint.sock' with CSI v1
I0919 14:44:27.165845 18632 service_manager.cpp:532] Probing endpoint
'unix:///tmp/mesos-csi-VB2zNm/endpoint.sock' with CSI v0
I0919 14:44:27.166823 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Identity/Probe call
I0919 14:44:27.169219 18643 container_daemon.cpp:171] Waiting for container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:27.171556 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Identity/GetPluginCapabilities call
I0919 14:44:27.172734 18633 process.cpp:3671] Handling HTTP event for process
'slave(1249)' with path: '/slave(1249)/api/v1'
I0919 14:44:27.173888 18634 http.cpp:1115] HTTP POST for /slave(1249)/api/v1
from 172.17.0.3:55124
I0919 14:44:27.174381 18634 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'
I0919 14:44:27.175597 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Identity/GetPluginInfo call
I0919 14:44:27.175860 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Identity/GetPluginInfo call
I0919 14:44:27.177557 18631 v0_volume_manager.cpp:628] NODE_SERVICE loaded: {}
I0919 14:44:27.178061 18631 v0_volume_manager.cpp:628] CONTROLLER_SERVICE
loaded: {}
I0919 14:44:27.178915 18651 hierarchical.cpp:1786] Performed allocation for 1
agents in 280644ns
I0919 14:44:27.180068 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Controller/ControllerGetCapabilities call
I0919 14:44:27.183383 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Node/NodeGetCapabilities call
I0919 14:44:27.186398 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Node/NodeGetId call
I0919 14:44:27.188480 18653 provider.cpp:676] Recovered resources '{}' and 0
operations for resource provider with type 'org.apache.mesos.rp.local.storage'
and name 'test'
I0919 14:44:27.188591 18647 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:27.188967 18648 http_connection.hpp:227] New endpoint detected at
http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.192361 18650 http_connection.hpp:283] Connected with the remote
endpoint at http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.193020 18637 provider.cpp:476] Connected to resource provider
manager
I0919 14:44:27.193639 18649 http_connection.hpp:131] Sending SUBSCRIBE call to
http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.194718 18634 process.cpp:3671] Handling HTTP event for process
'slave(1249)' with path: '/slave(1249)/api/v1/resource_provider'
I0919 14:44:27.196394 18638 http.cpp:1115] HTTP POST for
/slave(1249)/api/v1/resource_provider from 172.17.0.3:55128
I0919 14:44:27.197072 18653 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_M0UEL1","--available_capacity=0B","--volumes=","--forward=unix:///tmp/YTBE9G/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"}
I0919 14:44:27.228891 18641 slave.cpp:8482] Handling resource provider message
'SUBSCRIBE:
{"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"543300b2-fdb4-4ec3-9f0c-64a9c1c7e354"},"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_M0UEL1","--available_capacity=0B","--volumes=","--forward=unix:///tmp/YTBE9G/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"}'
I0919 14:44:27.229952 18646 hierarchical.cpp:1786] Performed allocation for 1
agents in 222496ns
I0919 14:44:27.230988 18644 provider.cpp:498] Received SUBSCRIBED event
I0919 14:44:27.231032 18644 provider.cpp:1309] Subscribed with ID
543300b2-fdb4-4ec3-9f0c-64a9c1c7e354
I0919 14:44:27.231818 18638 status_update_manager_process.hpp:314] Recovering
operation status update manager
I0919 14:44:27.278463 18653 provider.cpp:790] Reconciling storage pools and
volumes
I0919 14:44:27.280802 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Controller/ListVolumes call
I0919 14:44:27.281497 18631 hierarchical.cpp:1786] Performed allocation for 1
agents in 207006ns
I0919 14:44:27.283591 18634 provider.cpp:2217] Sending UPDATE_STATE call with
resources '{}' and 0 operations to agent aa4f9b23-ab02-4791-a49d-b165a668a288-S0
I0919 14:44:27.283905 18645 http_connection.hpp:131] Sending UPDATE_STATE call
to http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.283987 18634 provider.cpp:748] Resource provider
543300b2-fdb4-4ec3-9f0c-64a9c1c7e354 is in READY state
I0919 14:44:27.284039 18647 status_update_manager_process.hpp:385] Resuming
operation status update manager
I0919 14:44:27.284970 18636 provider.cpp:1235] Updating profiles { test } for
resource provider 543300b2-fdb4-4ec3-9f0c-64a9c1c7e354
I0919 14:44:27.285558 18652 process.cpp:3671] Handling HTTP event for process
'slave(1249)' with path: '/slave(1249)/api/v1/resource_provider'
I0919 14:44:27.286183 18650 provider.cpp:790] Reconciling storage pools and
volumes
I0919 14:44:27.287453 18645 http.cpp:1115] HTTP POST for
/slave(1249)/api/v1/resource_provider from 172.17.0.3:55126
I0919 14:44:27.288008 18634 manager.cpp:1045] Received UPDATE_STATE call with
resources '[]' and 0 operations from resource provider
543300b2-fdb4-4ec3-9f0c-64a9c1c7e354
I0919 14:44:27.288081 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Controller/ListVolumes call
I0919 14:44:27.288240 18644 slave.cpp:8482] Handling resource provider message
'UPDATE_STATE: 543300b2-fdb4-4ec3-9f0c-64a9c1c7e354 {}'
I0919 14:44:27.288363 18644 slave.cpp:8602] Forwarding new total resources
cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0919 14:44:27.288533 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Controller/GetCapacity call
I0919 14:44:27.290159 18631 hierarchical.cpp:1050] Grew agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 by {} (total), { } (used)
I0919 14:44:27.290522 18631 hierarchical.cpp:1008] Agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 (1b384509bb52) updated with total
resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0919 14:44:27.295336 18636 hierarchical.cpp:1786] Performed allocation for 1
agents in 148874ns
I0919 14:44:27.295751 18646 provider.cpp:790] Reconciling storage pools and
volumes
I0919 14:44:27.298288 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Controller/ListVolumes call
I0919 14:44:27.298826 32885 test_csi_plugin.cpp:1915] Forwarding
/csi.v0.Controller/GetCapacity call
I0919 14:44:27.309231 18642 slave.cpp:924] Agent terminating
I0919 14:44:27.310071 18642 manager.cpp:163] Terminating resource provider
543300b2-fdb4-4ec3-9f0c-64a9c1c7e354
I0919 14:44:27.310603 18643 master.cpp:1296] Agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 at slave(1249)@172.17.0.3:44477
(1b384509bb52) disconnected
I0919 14:44:27.310640 18643 master.cpp:3391] Disconnecting agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 at slave(1249)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:27.310720 18643 master.cpp:3410] Deactivating agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 at slave(1249)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:27.310886 18650 hierarchical.cpp:1096] Agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0 deactivated
E0919 14:44:27.311189 18634 http_connection.hpp:452] End-Of-File received
I0919 14:44:27.311894 18634 http_connection.hpp:217] Re-detecting endpoint
I0919 14:44:27.312494 18634 http_connection.hpp:338] Ignoring disconnection
attempt from stale connection
I0919 14:44:27.312536 18646 provider.cpp:488] Disconnected from resource
provider manager
I0919 14:44:27.312680 18648 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:27.312726 18634 http_connection.hpp:338] Ignoring disconnection
attempt from stale connection
I0919 14:44:27.312827 18634 http_connection.hpp:227] New endpoint detected at
http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.314726 18643 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
I0919 14:44:27.314796 18643 containerizer.cpp:3327] 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.54496secs
I0919 14:44:27.315595 18643 launcher.cpp:161] Asked to destroy container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:27.316537 18641 http_connection.hpp:283] Connected with the remote
endpoint at http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.317319 18654 provider.cpp:476] Connected to resource provider
manager
I0919 14:44:27.318022 18646 http_connection.hpp:131] Sending SUBSCRIBE call to
http://172.17.0.3:44477/slave(1249)/api/v1/resource_provider
I0919 14:44:27.318912 18655 process.cpp:2781] Returning '404 Not Found' for
'/slave(1249)/api/v1/resource_provider'
E0919 14:44:27.320298 18649 provider.cpp:721] Failed to subscribe resource
provider with type 'org.apache.mesos.rp.local.storage' and name 'test':
Received '404 Not Found' ()
I0919 14:44:27.340632 18638 hierarchical.cpp:1786] Performed allocation for 1
agents in 205802ns
I0919 14:44:27.392204 18639 containerizer.cpp:3165] Container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
has exited
I0919 14:44:27.392340 18644 hierarchical.cpp:1786] Performed allocation for 1
agents in 228727ns
I0919 14:44:27.393888 18646 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
I0919 14:44:27.396679 18652 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'
I0919 14:44:27.396893 18644 service_manager.cpp:723] Disconnected from endpoint
'unix:///tmp/mesos-csi-VB2zNm/endpoint.sock' of CSI plugin container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:27.397193 18637 container_daemon.cpp:121] Launching container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:27.400418 18655 process.cpp:2781] Returning '404 Not Found' for
'/slave(1249)/api/v1'
I0919 14:44:27.410578 18630 master.cpp:1137] Master terminating
I0919 14:44:27.411170 18650 hierarchical.cpp:1072] Removed all filters for
agent aa4f9b23-ab02-4791-a49d-b165a668a288-S0
I0919 14:44:27.411201 18650 hierarchical.cpp:949] Removed agent
aa4f9b23-ab02-4791-a49d-b165a668a288-S0
[ OK ] CSIVersion/StorageLocalResourceProviderTest.Update/v0 (747 ms)
[ RUN ] CSIVersion/StorageLocalResourceProviderTest.Update/v1
I0919 14:44:27.427723 18630 cluster.cpp:177] Creating default 'local' authorizer
I0919 14:44:27.432855 18646 master.cpp:440] Master
33e18b82-bd51-4706-88c2-ae9c67d0b607 (1b384509bb52) started on 172.17.0.3:44477
I0919 14:44:27.432888 18646 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/VBU1eq/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/VBU1eq/master" --zk_session_timeout="10secs"
I0919 14:44:27.433298 18646 master.cpp:492] Master only allowing authenticated
frameworks to register
I0919 14:44:27.433313 18646 master.cpp:498] Master only allowing authenticated
agents to register
I0919 14:44:27.433322 18646 master.cpp:504] Master only allowing authenticated
HTTP frameworks to register
I0919 14:44:27.433331 18646 credentials.hpp:37] Loading credentials for
authentication from '/tmp/VBU1eq/credentials'
I0919 14:44:27.433650 18646 master.cpp:548] Using default 'crammd5'
authenticator
I0919 14:44:27.433863 18646 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readonly'
I0919 14:44:27.434092 18646 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-readwrite'
I0919 14:44:27.434263 18646 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-master-scheduler'
I0919 14:44:27.434424 18646 master.cpp:629] Authorization enabled
I0919 14:44:27.434811 18643 hierarchical.cpp:532] Initialized hierarchical
allocator process
I0919 14:44:27.434834 18633 whitelist_watcher.cpp:77] No whitelist given
I0919 14:44:27.437851 18632 master.cpp:2169] Elected as the leading master!
I0919 14:44:27.437893 18632 master.cpp:1665] Recovering from registrar
I0919 14:44:27.438082 18641 registrar.cpp:339] Recovering registrar
I0919 14:44:27.438961 18641 registrar.cpp:383] Successfully fetched the
registry (0B) in 0ns
I0919 14:44:27.439128 18641 registrar.cpp:487] Applied 1 operations in 47750ns;
attempting to update the registry
I0919 14:44:27.439857 18641 registrar.cpp:544] Successfully updated the
registry in 0ns
I0919 14:44:27.440017 18641 registrar.cpp:416] Successfully recovered registrar
I0919 14:44:27.440809 18647 master.cpp:1818] Recovered 0 agents from the
registry (144B); allowing 10mins for agents to reregister
I0919 14:44:27.440850 18638 hierarchical.cpp:571] Skipping recovery of
hierarchical allocator: nothing to recover
W0919 14:44:27.447072 18630 process.cpp:2877] Attempted to spawn already
running process [email protected]:44477
I0919 14:44:27.448536 18630 containerizer.cpp:318] Using isolation {
environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0919 14:44:27.449122 18630 backend.cpp:76] Failed to create 'overlay' backend:
OverlayBackend requires root privileges
W0919 14:44:27.449153 18630 backend.cpp:76] Failed to create 'aufs' backend:
AufsBackend requires root privileges
W0919 14:44:27.449297 18630 backend.cpp:76] Failed to create 'bind' backend:
BindBackend requires root privileges
I0919 14:44:27.449339 18630 provisioner.cpp:300] Using default backend 'copy'
I0919 14:44:27.451915 18630 cluster.cpp:518] Creating default 'local' authorizer
I0919 14:44:27.454385 18640 slave.cpp:267] Mesos agent started on
(1250)@172.17.0.3:44477
I0919 14:44:27.454411 18640 slave.cpp:268] Flags at startup: --acls=""
--appc_simple_discovery_uri_prefix="http://";
--appc_store_dir="/tmp/VBU1eq/BBCmHR/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/VBU1eq/BBCmHR/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/VBU1eq/BBCmHR/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/VBU1eq/BBCmHR/fetch" --fetcher_cache_size="2GB"
--fetcher_stall_timeout="1mins"
--frameworks_home="/tmp/VBU1eq/BBCmHR/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/VBU1eq/BBCmHR/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/VBU1eq/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_cVe1jv"
--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_FkyGW8"
--zk_sessio
n_timeout="10secs"
I0919 14:44:27.454995 18640 credentials.hpp:86] Loading credential for
authentication from '/tmp/VBU1eq/BBCmHR/credential'
I0919 14:44:27.455181 18640 slave.cpp:300] Agent using credential for:
test-principal
I0919 14:44:27.455206 18640 credentials.hpp:37] Loading credentials for
authentication from '/tmp/VBU1eq/BBCmHR/http_credentials'
I0919 14:44:27.455405 18640 http.cpp:975] Creating default 'basic' HTTP
authenticator for realm 'mesos-agent-readonly'
I0919 14:44:27.455755 18640 disk_profile_adaptor.cpp:82] Creating disk profile
adaptor module 'org_apache_mesos_UriDiskProfileAdaptor'
I0919 14:44:27.457423 18646 uri_disk_profile_adaptor.cpp:305] Updated disk
profile mapping to 1 active profiles
I0919 14:44:27.457410 18640 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"}]
I0919 14:44:27.457636 18640 slave.cpp:623] Agent attributes: [ ]
I0919 14:44:27.457655 18640 slave.cpp:632] Agent hostname: 1b384509bb52
I0919 14:44:27.457813 18632 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:27.457875 18653 task_status_update_manager.cpp:181] Pausing sending
task status updates
I0919 14:44:27.459611 18650 state.cpp:67] Recovering state from
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_FkyGW8/meta'
I0919 14:44:27.459880 18631 slave.cpp:7492] Finished recovering checkpointed
state from
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_FkyGW8/meta',
beginning agent recovery
I0919 14:44:27.460510 18645 task_status_update_manager.cpp:207] Recovering task
status update manager
I0919 14:44:27.460927 18641 containerizer.cpp:821] Recovering Mesos containers
I0919 14:44:27.461376 18641 containerizer.cpp:1161] Recovering isolators
I0919 14:44:27.462355 18646 containerizer.cpp:1200] Recovering provisioner
I0919 14:44:27.463326 18639 provisioner.cpp:500] Provisioner recovery complete
I0919 14:44:27.463631 18652 hierarchical.cpp:1786] Performed allocation for 0
agents in 130784ns
I0919 14:44:27.464098 18647 composing.cpp:339] Finished recovering all
containerizers
I0919 14:44:27.464437 18634 slave.cpp:7973] Recovering executors
I0919 14:44:27.464553 18634 slave.cpp:8126] Finished recovery
I0919 14:44:27.465447 18633 task_status_update_manager.cpp:181] Pausing sending
task status updates
I0919 14:44:27.465479 18636 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:27.465529 18643 slave.cpp:1351] New master detected at
[email protected]:44477
I0919 14:44:27.465653 18643 slave.cpp:1416] Detecting new master
I0919 14:44:27.473012 18644 slave.cpp:1443] Authenticating with master
[email protected]:44477
I0919 14:44:27.473104 18644 slave.cpp:1452] Using default CRAM-MD5 authenticatee
I0919 14:44:27.473443 18654 authenticatee.cpp:121] Creating new client SASL
connection
I0919 14:44:27.473829 18646 master.cpp:10574] Authenticating
slave(1250)@172.17.0.3:44477
I0919 14:44:27.473989 18632 authenticator.cpp:414] Starting authentication
session for crammd5-authenticatee(2109)@172.17.0.3:44477
I0919 14:44:27.474323 18650 authenticator.cpp:98] Creating new server SASL
connection
I0919 14:44:27.474586 18639 authenticatee.cpp:213] Received SASL authentication
mechanisms: CRAM-MD5
I0919 14:44:27.474619 18639 authenticatee.cpp:239] Attempting to authenticate
with mechanism 'CRAM-MD5'
I0919 14:44:27.474754 18648 authenticator.cpp:204] Received SASL authentication
start
I0919 14:44:27.474853 18648 authenticator.cpp:326] Authentication requires more
steps
I0919 14:44:27.474980 18640 authenticatee.cpp:259] Received SASL authentication
step
I0919 14:44:27.475126 18645 authenticator.cpp:232] Received SASL authentication
step
I0919 14:44:27.475167 18645 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '1b384509bb52' server FQDN: '1b384509bb52'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: false
I0919 14:44:27.475184 18645 auxprop.cpp:181] Looking up auxiliary property
'*userPassword'
I0919 14:44:27.475229 18645 auxprop.cpp:181] Looking up auxiliary property
'*cmusaslsecretCRAM-MD5'
I0919 14:44:27.475255 18645 auxprop.cpp:109] Request to lookup properties for
user: 'test-principal' realm: '1b384509bb52' server FQDN: '1b384509bb52'
SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false
SASL_AUXPROP_AUTHZID: true
I0919 14:44:27.475270 18645 auxprop.cpp:131] Skipping auxiliary property
'*userPassword' since SASL_AUXPROP_AUTHZID == true
I0919 14:44:27.475281 18645 auxprop.cpp:131] Skipping auxiliary property
'*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0919 14:44:27.475301 18645 authenticator.cpp:318] Authentication success
I0919 14:44:27.475414 18635 authenticatee.cpp:299] Authentication success
I0919 14:44:27.475498 18652 master.cpp:10606] Successfully authenticated
principal 'test-principal' at slave(1250)@172.17.0.3:44477
I0919 14:44:27.475523 18631 authenticator.cpp:432] Authentication session
cleanup for crammd5-authenticatee(2109)@172.17.0.3:44477
I0919 14:44:27.475834 18645 slave.cpp:1543] Successfully authenticated with
master [email protected]:44477
I0919 14:44:27.476227 18645 slave.cpp:1993] Will retry registration in
2.412302ms if necessary
I0919 14:44:27.476431 18638 master.cpp:7069] Received register agent message
from slave(1250)@172.17.0.3:44477 (1b384509bb52)
I0919 14:44:27.476742 18638 master.cpp:4189] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0919 14:44:27.477500 18643 master.cpp:7136] Authorized registration of agent
at slave(1250)@172.17.0.3:44477 (1b384509bb52)
I0919 14:44:27.477605 18643 master.cpp:7248] Registering agent at
slave(1250)@172.17.0.3:44477 (1b384509bb52) with id
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0
I0919 14:44:27.478374 18653 registrar.cpp:487] Applied 1 operations in
250253ns; attempting to update the registry
I0919 14:44:27.479120 18653 registrar.cpp:544] Successfully updated the
registry in 677888ns
I0919 14:44:27.479302 18650 master.cpp:7296] Admitted agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:27.479902 18639 slave.cpp:1993] Will retry registration in
39.598115ms if necessary
I0919 14:44:27.480172 18639 slave.cpp:1576] Registered with master
[email protected]:44477; given agent ID 33e18b82-bd51-4706-88c2-ae9c67d0b607-S0
I0919 14:44:27.480177 18650 master.cpp:7341] Registered agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0919 14:44:27.480293 18647 task_status_update_manager.cpp:188] Resuming
sending task status updates
I0919 14:44:27.480317 18640 hierarchical.cpp:912] Added agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 (1b384509bb52) with cpus:2; mem:1024;
disk:1024; ports:[31000-32000] (offered or allocated: {})
I0919 14:44:27.480547 18650 master.cpp:7069] Received register agent message
from slave(1250)@172.17.0.3:44477 (1b384509bb52)
I0919 14:44:27.480633 18639 slave.cpp:1611] Checkpointing SlaveInfo to
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_FkyGW8/meta/slaves/33e18b82-bd51-4706-88c2-ae9c67d0b607-S0/slave.info'
I0919 14:44:27.480707 18652 status_update_manager_process.hpp:385] Resuming
operation status update manager
I0919 14:44:27.480756 18640 hierarchical.cpp:1786] Performed allocation for 1
agents in 192086ns
I0919 14:44:27.481011 18650 master.cpp:4189] Authorizing agent providing
resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal
'test-principal'
I0919 14:44:27.481608 18645 master.cpp:7136] Authorized registration of agent
at slave(1250)@172.17.0.3:44477 (1b384509bb52)
I0919 14:44:27.481714 18645 master.cpp:7227] Agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52) already registered, resending acknowledgement
I0919 14:44:27.481869 18639 slave.cpp:1663] Forwarding agent update
{"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"iXlOP5aVQq+kF9oxi/d0gg=="},"slave_id":{"value":"33e18b82-bd51-4706-88c2-ae9c67d0b607-S0"},"update_oversubscribed_resources":false}
W0919 14:44:27.482117 18639 slave.cpp:1645] Already registered with master
[email protected]:44477
I0919 14:44:27.482235 18639 slave.cpp:1663] Forwarding agent update
{"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"iXlOP5aVQq+kF9oxi/d0gg=="},"slave_id":{"value":"33e18b82-bd51-4706-88c2-ae9c67d0b607-S0"},"update_oversubscribed_resources":false}
I0919 14:44:27.482615 18641 master.cpp:8460] Ignoring update on agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52) as it reports no changes
I0919 14:44:27.483156 18641 master.cpp:8460] Ignoring update on agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52) as it reports no changes
I0919 14:44:27.486788 18635 process.cpp:3671] Handling HTTP event for process
'slave(1250)' with path: '/slave(1250)/api/v1'
I0919 14:44:27.488072 18645 http.cpp:1115] HTTP POST for /slave(1250)/api/v1
from 172.17.0.3:55140
I0919 14:44:27.488570 18645 http.cpp:2146] Processing GET_CONTAINERS call
I0919 14:44:27.493911 18647 container_daemon.cpp:121] Launching container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:27.496418 18635 process.cpp:3671] Handling HTTP event for process
'slave(1250)' with path: '/slave(1250)/api/v1'
I0919 14:44:27.497388 18645 http.cpp:1115] HTTP POST for /slave(1250)/api/v1
from 172.17.0.3:55142
I0919 14:44:27.498091 18645 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'
I0919 14:44:27.498909 18631 http.cpp:2710] Creating sandbox
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_FkyGW8/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:27.499533 18632 containerizer.cpp:1396] Starting container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:27.500155 18632 containerizer.cpp:3327] 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 224us
I0919 14:44:27.500865 18632 containerizer.cpp:1574] Checkpointed
ContainerConfig at
'/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_cVe1jv/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE/config'
I0919 14:44:27.500916 18632 containerizer.cpp:3327] 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 762112ns
I0919 14:44:27.503844 18652 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_K7LmzM","--available_capacity=0B","--volumes=","--forward=unix:///tmp/VBU1eq/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_FkyGW8/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-SOzQyj/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_FkyGW8/containers/org-apache-mesos-rp-local
-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"}"
--pipe_read="94" --pipe_write="95"
--runtime_directory="/tmp/CSIVersion_StorageLocalResourceProviderTest_Update_v1_cVe1jv/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE"
--unshare_namespace_mnt="false"'
I0919 14:44:27.512828 18652 launcher.cpp:145] Forked child with pid '32896' for
container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:27.514101 18652 containerizer.cpp:3327] 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 13.154816ms
I0919 14:44:27.515244 18642 hierarchical.cpp:1786] Performed allocation for 1
agents in 370787ns
I0919 14:44:27.515903 18652 containerizer.cpp:3327] 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.811968ms
I0919 14:44:27.516266 18645 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_FkyGW8/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:27.517408 18654 containerizer.cpp:3327] 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 1.45024ms
I0919 14:44:27.520437 18641 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'
I0919 14:44:27.520787 18644 service_manager.cpp:703] Connecting to endpoint
'unix:///tmp/mesos-csi-SOzQyj/endpoint.sock' of CSI plugin container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:27.567636 18649 hierarchical.cpp:1786] Performed allocation for 1
agents in 313599ns
I0919 14:44:27.619043 18654 hierarchical.cpp:1786] Performed allocation for 1
agents in 143540ns
I0919 14:44:27.670389 18641 hierarchical.cpp:1786] Performed allocation for 1
agents in 118312ns
I0919 14:44:27.721418 18647 hierarchical.cpp:1786] Performed allocation for 1
agents in 234429ns
I0919 14:44:27.772683 18643 hierarchical.cpp:1786] Performed allocation for 1
agents in 236446ns
I0919 14:44:27.824594 18631 hierarchical.cpp:1786] Performed allocation for 1
agents in 244854ns
I0919 14:44:27.875851 18640 hierarchical.cpp:1786] Performed allocation for 1
agents in 173908ns
I0919 14:44:27.927302 18633 hierarchical.cpp:1786] Performed allocation for 1
agents in 295746ns
I0919 14:44:27.978920 18645 hierarchical.cpp:1786] Performed allocation for 1
agents in 274464ns
I0919 14:44:28.030267 18641 hierarchical.cpp:1786] Performed allocation for 1
agents in 232291ns
I0919 14:44:28.081655 18647 hierarchical.cpp:1786] Performed allocation for 1
agents in 232707ns
I0919 14:44:28.112022 18633 service_manager.cpp:545] Probing endpoint
'unix:///tmp/mesos-csi-SOzQyj/endpoint.sock' with CSI v1
I0919 14:44:28.113765 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Identity/Probe call
I0919 14:44:28.116736 18652 container_daemon.cpp:171] Waiting for container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:28.119081 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Identity/GetPluginCapabilities call
I0919 14:44:28.120164 18651 process.cpp:3671] Handling HTTP event for process
'slave(1250)' with path: '/slave(1250)/api/v1'
I0919 14:44:28.121503 18635 http.cpp:1115] HTTP POST for /slave(1250)/api/v1
from 172.17.0.3:55144
I0919 14:44:28.122117 18635 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'
I0919 14:44:28.123014 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Identity/GetPluginInfo call
I0919 14:44:28.123287 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Identity/GetPluginInfo call
I0919 14:44:28.125108 18646 v1_volume_manager.cpp:649] NODE_SERVICE loaded: {}
I0919 14:44:28.125655 18646 v1_volume_manager.cpp:649] CONTROLLER_SERVICE
loaded: {}
I0919 14:44:28.127621 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Controller/ControllerGetCapabilities call
I0919 14:44:28.130877 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Node/NodeGetCapabilities call
I0919 14:44:28.133204 18633 hierarchical.cpp:1786] Performed allocation for 1
agents in 192106ns
I0919 14:44:28.134073 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Node/NodeGetInfo call
I0919 14:44:28.136199 18637 provider.cpp:676] Recovered resources '{}' and 0
operations for resource provider with type 'org.apache.mesos.rp.local.storage'
and name 'test'
I0919 14:44:28.136346 18643 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:28.136701 18654 http_connection.hpp:227] New endpoint detected at
http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.139675 18653 http_connection.hpp:283] Connected with the remote
endpoint at http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.140266 18650 provider.cpp:476] Connected to resource provider
manager
I0919 14:44:28.140944 18649 http_connection.hpp:131] Sending SUBSCRIBE call to
http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.141929 18634 process.cpp:3671] Handling HTTP event for process
'slave(1250)' with path: '/slave(1250)/api/v1/resource_provider'
I0919 14:44:28.143532 18637 http.cpp:1115] HTTP POST for
/slave(1250)/api/v1/resource_provider from 172.17.0.3:55148
I0919 14:44:28.144193 18636 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_K7LmzM","--available_capacity=0B","--volumes=","--forward=unix:///tmp/VBU1eq/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"}
I0919 14:44:28.174223 18647 slave.cpp:8482] Handling resource provider message
'SUBSCRIBE:
{"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"6edfa299-6d5d-4685-af74-8e4f94328b47"},"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_K7LmzM","--available_capacity=0B","--volumes=","--forward=unix:///tmp/VBU1eq/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"}'
I0919 14:44:28.175639 18634 provider.cpp:498] Received SUBSCRIBED event
I0919 14:44:28.175679 18634 provider.cpp:1309] Subscribed with ID
6edfa299-6d5d-4685-af74-8e4f94328b47
I0919 14:44:28.176538 18643 status_update_manager_process.hpp:314] Recovering
operation status update manager
I0919 14:44:28.184826 18637 hierarchical.cpp:1786] Performed allocation for 1
agents in 254833ns
I0919 14:44:28.236357 18654 hierarchical.cpp:1786] Performed allocation for 1
agents in 130758ns
I0919 14:44:28.287230 18639 hierarchical.cpp:1786] Performed allocation for 1
agents in 109588ns
I0919 14:44:28.292896 18652 provider.cpp:790] Reconciling storage pools and
volumes
I0919 14:44:28.295550 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Controller/ListVolumes call
I0919 14:44:28.298224 18642 provider.cpp:2217] Sending UPDATE_STATE call with
resources '{}' and 0 operations to agent 33e18b82-bd51-4706-88c2-ae9c67d0b607-S0
I0919 14:44:28.298506 18643 http_connection.hpp:131] Sending UPDATE_STATE call
to http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.298578 18642 provider.cpp:748] Resource provider
6edfa299-6d5d-4685-af74-8e4f94328b47 is in READY state
I0919 14:44:28.298614 18637 status_update_manager_process.hpp:385] Resuming
operation status update manager
I0919 14:44:28.299278 18639 provider.cpp:1235] Updating profiles { test } for
resource provider 6edfa299-6d5d-4685-af74-8e4f94328b47
I0919 14:44:28.299618 18636 process.cpp:3671] Handling HTTP event for process
'slave(1250)' with path: '/slave(1250)/api/v1/resource_provider'
I0919 14:44:28.300356 18644 provider.cpp:790] Reconciling storage pools and
volumes
I0919 14:44:28.301358 18645 http.cpp:1115] HTTP POST for
/slave(1250)/api/v1/resource_provider from 172.17.0.3:55146
I0919 14:44:28.301882 18637 manager.cpp:1045] Received UPDATE_STATE call with
resources '[]' and 0 operations from resource provider
6edfa299-6d5d-4685-af74-8e4f94328b47
I0919 14:44:28.302139 18654 slave.cpp:8482] Handling resource provider message
'UPDATE_STATE: 6edfa299-6d5d-4685-af74-8e4f94328b47 {}'
I0919 14:44:28.302258 18654 slave.cpp:8602] Forwarding new total resources
cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0919 14:44:28.302716 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Controller/ListVolumes call
I0919 14:44:28.303242 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Controller/GetCapacity call
I0919 14:44:28.303915 18640 hierarchical.cpp:1050] Grew agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 by {} (total), { } (used)
I0919 14:44:28.304260 18640 hierarchical.cpp:1008] Agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 (1b384509bb52) updated with total
resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0919 14:44:28.308802 18654 hierarchical.cpp:1786] Performed allocation for 1
agents in 192927ns
I0919 14:44:28.308946 18650 provider.cpp:790] Reconciling storage pools and
volumes
I0919 14:44:28.310640 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Controller/ListVolumes call
I0919 14:44:28.311013 32900 test_csi_plugin.cpp:1915] Forwarding
/csi.v1.Controller/GetCapacity call
I0919 14:44:28.322110 18630 slave.cpp:924] Agent terminating
I0919 14:44:28.322924 18630 manager.cpp:163] Terminating resource provider
6edfa299-6d5d-4685-af74-8e4f94328b47
I0919 14:44:28.323319 18643 master.cpp:1296] Agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52) disconnected
I0919 14:44:28.323356 18643 master.cpp:3391] Disconnecting agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:28.323431 18643 master.cpp:3410] Deactivating agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 at slave(1250)@172.17.0.3:44477
(1b384509bb52)
I0919 14:44:28.323611 18637 hierarchical.cpp:1096] Agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0 deactivated
E0919 14:44:28.323844 18642 http_connection.hpp:452] End-Of-File received
I0919 14:44:28.324297 18642 http_connection.hpp:217] Re-detecting endpoint
I0919 14:44:28.324723 18642 http_connection.hpp:338] Ignoring disconnection
attempt from stale connection
I0919 14:44:28.324806 18632 provider.cpp:488] Disconnected from resource
provider manager
I0919 14:44:28.324827 18642 http_connection.hpp:338] Ignoring disconnection
attempt from stale connection
I0919 14:44:28.324929 18640 status_update_manager_process.hpp:379] Pausing
operation status update manager
I0919 14:44:28.324992 18642 http_connection.hpp:227] New endpoint detected at
http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.326388 18639 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
I0919 14:44:28.326450 18639 containerizer.cpp:3327] 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.809113856secs
I0919 14:44:28.326932 18639 launcher.cpp:161] Asked to destroy container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:28.328397 18648 http_connection.hpp:283] Connected with the remote
endpoint at http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.328968 18638 provider.cpp:476] Connected to resource provider
manager
I0919 14:44:28.329574 18652 http_connection.hpp:131] Sending SUBSCRIBE call to
http://172.17.0.3:44477/slave(1250)/api/v1/resource_provider
I0919 14:44:28.330404 18655 process.cpp:2781] Returning '404 Not Found' for
'/slave(1250)/api/v1/resource_provider'
E0919 14:44:28.331640 18649 provider.cpp:721] Failed to subscribe resource
provider with type 'org.apache.mesos.rp.local.storage' and name 'test':
Received '404 Not Found' ()
I0919 14:44:28.355754 18644 hierarchical.cpp:1786] Performed allocation for 1
agents in 193904ns
I0919 14:44:28.406083 18637 containerizer.cpp:3165] Container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
has exited
I0919 14:44:28.407517 18645 hierarchical.cpp:1786] Performed allocation for 1
agents in 186189ns
I0919 14:44:28.407769 18654 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
I0919 14:44:28.410411 18643 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'
I0919 14:44:28.410609 18634 service_manager.cpp:723] Disconnected from endpoint
'unix:///tmp/mesos-csi-SOzQyj/endpoint.sock' of CSI plugin container
org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE
I0919 14:44:28.410856 18641 container_daemon.cpp:121] Launching container
'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local--CONTROLLER_SERVICE-NODE_SERVICE'
I0919 14:44:28.413681 18655 process.cpp:2781] Returning '404 Not Found' for
'/slave(1250)/api/v1'
I0919 14:44:28.423455 18630 master.cpp:1137] Master terminating
I0919 14:44:28.424010 18648 hierarchical.cpp:1072] Removed all filters for
agent 33e18b82-bd51-4706-88c2-ae9c67d0b607-S0
I0919 14:44:28.424039 18648 hierarchical.cpp:949] Removed agent
33e18b82-bd51-4706-88c2-ae9c67d0b607-S0
[ OK ] CSIVersion/StorageLocalResourceProviderTest.Update/v1 (1010 ms)
[----------] 54 tests from CSIVersion/StorageLocalResourceProviderTest (95757
ms total)
[----------] Global test environment tear-down
../../src/tests/environment.cpp:1161: Failure
Failed
Tests completed with child processes remaining:
-+- 18630 ./mesos-tests
\-+- 23423 /mesos/mesos-1.10.0/_build/src/mesos-containerizer launch
\-+- 23425 sh -c sleep 1000
\--- 23426 sleep 1000
[==========] 2318 tests from 221 test cases ran. (1049327 ms total)
[ PASSED ] 2317 tests.
[ FAILED ] 1 test, listed below:
[ FAILED ] GarbageCollectorIntegrationTest.OrphanContainer
1 FAILED TEST
YOU HAVE 32 DISABLED TESTS
I0919 14:44:28.530246 18655 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-1568898265-5772
Untagged: mesos-1568898265-5772:latest
Deleted: sha256:145cfd23e3e3b03cdd4cb16f2ac1286c13747401ef2f058a90d7b40d657473ee
Deleted: sha256:4620b2813155cd64da2ae83a07aa60207b8258a67c25ebcc45f136d6f259c22a
Deleted: sha256:feaab8325e7fbc57e75ca74b91ea501843b0b804fafce9143521640c68c8c295
Deleted: sha256:ed129cd9764099576cadf551e6c5b9f02be7ea98149c73e9fcad439bcc8c7c62
Deleted: sha256:7c55c15424ea25b33f02ee150842f51f425725f9a17416c5f7dc4dc654cc5c8e
Deleted: sha256:afa94831b6a03184ea534cc3debdfbecdff07439de28032acd7e29d9cfbdc40e
Deleted: sha256:7379dfa49cf7750d9b85b80dbd43b3a6d46ffae08cf7adecf19189d2e160725a
Deleted: sha256:ef639ed0156ca3468650c6e69cdfc50e2bb4ece37f3fdfd461be34a41a06756b
Deleted: sha256:1d96190c17ad7ff3350087aa2e97d87ae2a60d2fae9990689da2a2f1bf2657e8
Deleted: sha256:deacb82178f1061596e06cfc13adc12ef1a2969c098805e2ebae6808b3c385a1
Deleted: sha256:01ff77c2dbe82fb70b5332a089a55c3b9ae8d4e8a279c55bd72be17cae6ecd4a
Deleted: sha256:63a36ace27742d392ba68c63c20b35ea777b8aaa202ff14e06c8997e1c73e500
Deleted: sha256:0543c9d74ff8fff3ee7c4589a4d2383370f5da14cbb231433da145b05aff187e
Deleted: sha256:f45efb330fd852d4ef22c97251064afd6bfe5f3babc48a3f6824747a32054d42
Deleted: sha256:6665afdbbfaa1578c6bd9d9f31defe8afc3cead65a2200c218e1cbb311c3b2af
Deleted: sha256:e830d2cc623d90a8a41e3ba687517d91ae6475f40054db6811bb97e9e39b35d7
Deleted: sha256:bbb5b2fe543b2166e33888bb3823ca1dd303c358552c4991c6d9fb24f3ac7580
Deleted: sha256:c7a25d05ece8fc48795761ceb63c148dfd2b1113dfe26dacb90ee0576eb90ea0
Deleted: sha256:e4c51a918d240632b292d5bb92bdb3a20b9b0bc207517672afa917dc89b03837
Deleted: sha256:37da1844d346b6329cf75e9833af021dcc1604954c43dad534a562f7f9c73e44
Deleted: sha256:54d7b96b5754666b76a057e23342be8f2851d9d970f92e35789809f6c17a19e3
Deleted: sha256:36f5431ccd311fc5d10c04da5e8bea8d0fd0a236878e9735c1c1166006d8958f
Deleted: sha256:9108fc3a63c2928273185479b465843e1388fa5cd3beb62a416e6ea3fb4f41b3
Deleted: sha256:2746c8eb4b5a6d820d673c8390ac1c9b671bb897f636ed48fc7223f4f5bc3abb
Deleted: sha256:66e0448a7c70e7e8adc6f4c9faea58265eac104a004ae3c83b14de14d78e4452
Deleted: sha256:c589c6061f368fec04616691e768fe820a7ce864d230eec86a1110b8464e6ba1
Deleted: sha256:d05d3e0dae3a0d6b28d4b00b04b27ea7224cd9daded80411a8c86eea17109601
Deleted: sha256:ebb8807038a587e7702cd6ae529ba3c326b128b2f187845ab45c98e1a0e67ed4
Deleted: sha256:f7bc4415dcc12488b6b2a69a39b0eff648c5038e3b490673637484f96325780c
Deleted: sha256:b27a9d050c69dde7763571d595fb8eb065e505024abf0f4ab6938f2dbcaec1b3
Full log: https://builds.apache.org/job/Mesos-Reviewbot-Linux/3787/console
- Mesos Reviewbot
On Sept. 19, 2019, 12:19 p.m., Qian Zhang wrote:
>
> -----------------------------------------------------------
> This is an automatically generated e-mail. To reply, visit:
> https://reviews.apache.org/r/71518/
> -----------------------------------------------------------
>
> (Updated Sept. 19, 2019, 12:19 p.m.)
>
>
> Review request for mesos and Gilbert Song.
>
>
> Bugs: MESOS-9966
> https://issues.apache.org/jira/browse/MESOS-9966
>
>
> Repository: mesos
>
>
> Description
> -------
>
> Added the test `GarbageCollectorIntegrationTest.OrphanContainer`.
>
>
> Diffs
> -----
>
> src/tests/gc_tests.cpp 2ea4bcb668e1fcbeb9c598053e4df4d54d17711d
>
>
> Diff: https://reviews.apache.org/r/71518/diff/1/
>
>
> Testing
> -------
>
> sudo make check
>
> This test will fail without the previous patch r/71501.
>
>
> Thanks,
>
> Qian Zhang
>
>
