You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@mesos.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/04/09 05:17:15 UTC
Build failed in Jenkins: Mesos-Reviewbot-Linux #716
See <https://builds.apache.org/job/Mesos-Reviewbot-Linux/716/display/redirect?page=changes>
Changes:
[mzhu] Parameterized some allocator benchmarks for DRF and random sorters.
------------------------------------------
[...truncated 45.40 MB...]
I0409 03:42:26.172353 20162 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7ed09a2c5c07' server FQDN: '7ed09a2c5c07' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0409 03:42:26.172372 20162 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0409 03:42:26.172385 20162 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0409 03:42:26.172413 20162 authenticator.cpp:318] Authentication success
I0409 03:42:26.172574 20153 authenticatee.cpp:299] Authentication success
I0409 03:42:26.172744 20155 master.cpp:10224] Successfully authenticated principal 'test-principal' at slave(1102)@172.17.0.2:40730
I0409 03:42:26.172770 20152 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1905)@172.17.0.2:40730
I0409 03:42:26.173123 20150 slave.cpp:1450] Successfully authenticated with master master@172.17.0.2:40730
I0409 03:42:26.173585 20150 slave.cpp:1897] Will retry registration in 7.357938ms if necessary
I0409 03:42:26.173909 20157 master.cpp:6821] Received register agent message from slave(1102)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:26.174440 20157 master.cpp:4053] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I0409 03:42:26.175571 20169 master.cpp:6888] Authorized registration of agent at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:26.175722 20169 master.cpp:7003] Registering agent at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07) with id b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0
I0409 03:42:26.176645 20167 registrar.cpp:487] Applied 1 operations in 278288ns; attempting to update the registry
I0409 03:42:26.177618 20167 registrar.cpp:544] Successfully updated the registry in 0ns
I0409 03:42:26.177901 20151 master.cpp:7051] Admitted agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:26.179039 20151 master.cpp:7096] Registered agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0409 03:42:26.179127 20154 slave.cpp:1483] Registered with master master@172.17.0.2:40730; given agent ID b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0
I0409 03:42:26.179312 20162 task_status_update_manager.cpp:188] Resuming sending task status updates
I0409 03:42:26.179302 20165 hierarchical.cpp:640] Added agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 (7ed09a2c5c07) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0409 03:42:26.179713 20154 slave.cpp:1518] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_IuWOjB/meta/slaves/b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0/slave.info'
I0409 03:42:26.179785 20165 hierarchical.cpp:1595] Performed allocation for 1 agents in 162280ns
I0409 03:42:26.179908 20164 status_update_manager_process.hpp:385] Resuming operation status update manager
I0409 03:42:26.181082 20154 slave.cpp:1567] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"S6R4OCN2QG2ZWjpnDoDhjg=="},"slave_id":{"value":"b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0"},"update_oversubscribed_resources":false}
I0409 03:42:26.181949 20150 master.cpp:8174] Ignoring update on agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07) as it reports no changes
I0409 03:42:26.188057 20159 process.cpp:3588] Handling HTTP event for process 'slave(1102)' with path: '/slave(1102)/api/v1'
I0409 03:42:26.189829 20155 http.cpp:1105] HTTP POST for /slave(1102)/api/v1 from 172.17.0.2:39854
I0409 03:42:26.190485 20155 http.cpp:2113] Processing GET_CONTAINERS call
I0409 03:42:26.197304 20160 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.200444 20146 process.cpp:3588] Handling HTTP event for process 'slave(1102)' with path: '/slave(1102)/api/v1'
I0409 03:42:26.201642 20164 http.cpp:1105] HTTP POST for /slave(1102)/api/v1 from 172.17.0.2:39856
I0409 03:42:26.202600 20164 http.cpp:2479] Processing LAUNCH_CONTAINER call for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.203788 20156 http.cpp:2583] Creating sandbox '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_IuWOjB/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.204479 20166 containerizer.cpp:1358] Starting container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE
I0409 03:42:26.205760 20166 containerizer.cpp:1530] Checkpointed ContainerConfig at '/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_GKNR1j/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE/config'
I0409 03:42:26.205811 20166 containerizer.cpp:3278] Transitioning the state of container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE from PROVISIONING to PREPARING
I0409 03:42:26.208868 20158 containerizer.cpp:2056] Launching 'mesos-containerizer' with flags '--help="false" --launch_info="{"command":{"arguments":["/mesos/mesos-1.9.0/_build/src/test-csi-plugin","--available_capacity=0B","--volumes=volume1:4GB","--work_dir=/tmp/41DNBS/local_d22829ff8d444ede8e691c4ef415676c"],"shell":false,"value":"/mesos/mesos-1.9.0/_build/src/test-csi-plugin"},"environment":{"variables":[{"name":"MESOS_SANDBOX","type":"VALUE","value":"/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_IuWOjB/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE"},{"name":"CSI_ENDPOINT","type":"VALUE","value":"unix:///tmp/mesos-csi-TdVh0V/endpoint.sock"}]},"task_environment":{},"working_directory":"/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_IuWOjB/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE"}" --pipe_read="73" --pipe_write="74" --runtime_directory="/tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_GKNR1j/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE" --unshare_namespace_mnt="false"'
I0409 03:42:26.218663 20158 launcher.cpp:145] Forked child with pid '861' for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.219696 20158 containerizer.cpp:3278] Transitioning the state of container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE from PREPARING to ISOLATING
I0409 03:42:26.221500 20158 containerizer.cpp:3278] Transitioning the state of container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE from ISOLATING to FETCHING
I0409 03:42:26.221990 20146 fetcher.cpp:369] Starting to fetch URIs for container: org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE, directory: /tmp/ContentType_AgentResourceProviderConfigApiTest_IdempotentAdd_1_IuWOjB/containers/org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE
I0409 03:42:26.223503 20159 containerizer.cpp:3278] Transitioning the state of container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE from FETCHING to RUNNING
I0409 03:42:26.226833 20156 container_daemon.cpp:140] Invoking post-start hook for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.227084 20154 service_manager.cpp:698] Connecting to endpoint 'unix:///tmp/mesos-csi-TdVh0V/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE
I0409 03:42:26.374594 20160 hierarchical.cpp:1595] Performed allocation for 1 agents in 281127ns
I0409 03:42:26.426779 20153 hierarchical.cpp:1595] Performed allocation for 1 agents in 193689ns
I0409 03:42:26.478013 20155 hierarchical.cpp:1595] Performed allocation for 1 agents in 131191ns
I0409 03:42:26.529804 20169 hierarchical.cpp:1595] Performed allocation for 1 agents in 202988ns
I0409 03:42:26.581374 20149 hierarchical.cpp:1595] Performed allocation for 1 agents in 182223ns
I0409 03:42:26.632663 20165 hierarchical.cpp:1595] Performed allocation for 1 agents in 179880ns
I0409 03:42:26.684218 20150 hierarchical.cpp:1595] Performed allocation for 1 agents in 194491ns
I0409 03:42:26.710253 20169 service_manager.cpp:540] Probing endpoint 'unix:///tmp/mesos-csi-TdVh0V/endpoint.sock' with CSI v1
I0409 03:42:26.725837 865 test_csi_plugin.cpp:894] ProbeRequest '{}'
I0409 03:42:26.727669 20167 container_daemon.cpp:171] Waiting for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.729995 866 test_csi_plugin.cpp:880] GetPluginCapabilitiesRequest '{}'
I0409 03:42:26.730921 20157 process.cpp:3588] Handling HTTP event for process 'slave(1102)' with path: '/slave(1102)/api/v1'
I0409 03:42:26.731967 20163 http.cpp:1105] HTTP POST for /slave(1102)/api/v1 from 172.17.0.2:39858
I0409 03:42:26.732470 20163 http.cpp:2697] Processing WAIT_CONTAINER call for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.733234 866 test_csi_plugin.cpp:862] GetPluginInfoRequest '{}'
I0409 03:42:26.733554 865 test_csi_plugin.cpp:862] GetPluginInfoRequest '{}'
I0409 03:42:26.734803 20158 v1_volume_manager.cpp:649] NODE_SERVICE loaded: {"name":".","vendorVersion":"1.9.0"}
I0409 03:42:26.735265 20158 v1_volume_manager.cpp:649] CONTROLLER_SERVICE loaded: {"name":".","vendorVersion":"1.9.0"}
I0409 03:42:26.735941 20165 hierarchical.cpp:1595] Performed allocation for 1 agents in 166396ns
I0409 03:42:26.737217 866 test_csi_plugin.cpp:1093] ControllerGetCapabilitiesRequest '{}'
I0409 03:42:26.740005 866 test_csi_plugin.cpp:1227] NodeGetCapabilitiesRequest '{}'
I0409 03:42:26.742693 866 test_csi_plugin.cpp:1241] NodeGetInfoRequest '{}'
I0409 03:42:26.744439 20167 provider.cpp:613] Finished recovery for resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test'
I0409 03:42:26.744580 20151 status_update_manager_process.hpp:379] Pausing operation status update manager
I0409 03:42:26.744899 20149 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.747676 20165 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.748273 20150 provider.cpp:433] Connected to resource provider manager
I0409 03:42:26.748877 20166 http_connection.hpp:131] Sending 1 call to http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.749832 20168 process.cpp:3588] Handling HTTP event for process 'slave(1102)' with path: '/slave(1102)/api/v1/resource_provider'
I0409 03:42:26.751307 20167 http.cpp:1105] HTTP POST for /slave(1102)/api/v1/resource_provider from 172.17.0.2:39862
I0409 03:42:26.751916 20146 manager.cpp:807] Subscribing resource provider {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.9.0/_build/src/test-csi-plugin","--available_capacity=0B","--volumes=volume1:4GB","--work_dir=/tmp/41DNBS/local_d22829ff8d444ede8e691c4ef415676c"],"shell":false,"value":"/mesos/mesos-1.9.0/_build/src/test-csi-plugin"},"resources":[{"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}],"services":["CONTROLLER_SERVICE","NODE_SERVICE"]}],"name":"local_d22829ff8d444ede8e691c4ef415676c","type":"org.apache.mesos.csi.test"}},"type":"org.apache.mesos.rp.local.storage"}
I0409 03:42:26.782490 20152 slave.cpp:8177] Handling resource provider message 'SUBSCRIBE: {"default_reservations":[{"role":"storage","type":"DYNAMIC"}],"id":{"value":"4405065b-b461-466b-83a8-d1ea638000f7"},"name":"test","storage":{"plugin":{"containers":[{"command":{"arguments":["/mesos/mesos-1.9.0/_build/src/test-csi-plugin","--available_capacity=0B","--volumes=volume1:4GB","--work_dir=/tmp/41DNBS/local_d22829ff8d444ede8e691c4ef415676c"],"shell":false,"value":"/mesos/mesos-1.9.0/_build/src/test-csi-plugin"},"resources":[{"name":"cpus","scalar":{"value":0.1},"type":"SCALAR"},{"name":"mem","scalar":{"value":1024.0},"type":"SCALAR"}],"services":["CONTROLLER_SERVICE","NODE_SERVICE"]}],"name":"local_d22829ff8d444ede8e691c4ef415676c","type":"org.apache.mesos.csi.test"}},"type":"org.apache.mesos.rp.local.storage"}'
I0409 03:42:26.785140 20169 provider.cpp:455] Received SUBSCRIBED event
I0409 03:42:26.785210 20169 provider.cpp:1159] Subscribed with ID 4405065b-b461-466b-83a8-d1ea638000f7
I0409 03:42:26.786489 20148 status_update_manager_process.hpp:314] Recovering operation status update manager
I0409 03:42:26.787101 20167 hierarchical.cpp:1595] Performed allocation for 1 agents in 242577ns
I0409 03:42:26.838176 20149 hierarchical.cpp:1595] Performed allocation for 1 agents in 160055ns
I0409 03:42:26.843499 866 test_csi_plugin.cpp:1036] ListVolumesRequest '{}'
I0409 03:42:26.847470 20152 provider.cpp:685] Removing '{}' and adding 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c,volume1,)]:4096' to the total resources
I0409 03:42:26.889662 20150 hierarchical.cpp:1595] Performed allocation for 1 agents in 133947ns
I0409 03:42:26.907265 20152 provider.cpp:2049] Sending UPDATE_STATE call with resources 'disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c,volume1,)]:4096' and 0 operations to agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0
I0409 03:42:26.907871 20152 provider.cpp:699] Resource provider 4405065b-b461-466b-83a8-d1ea638000f7 is in READY state
I0409 03:42:26.907956 20163 status_update_manager_process.hpp:385] Resuming operation status update manager
I0409 03:42:26.908031 20147 http_connection.hpp:131] Sending 3 call to http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.909742 20160 process.cpp:3588] Handling HTTP event for process 'slave(1102)' with path: '/slave(1102)/api/v1/resource_provider'
I0409 03:42:26.912231 20146 http.cpp:1105] HTTP POST for /slave(1102)/api/v1/resource_provider from 172.17.0.2:39860
I0409 03:42:26.913126 20161 manager.cpp:1039] Received UPDATE_STATE call with resources '[{"disk":{"source":{"id":"volume1","metadata":{"labels":[{"key":"path","value":"/tmp/41DNBS/local_d22829ff8d444ede8e691c4ef415676c/4GB-volume1"}]},"type":"RAW","vendor":"org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c"}},"name":"disk","provider_id":{"value":"4405065b-b461-466b-83a8-d1ea638000f7"},"reservations":[{"role":"storage","type":"DYNAMIC"}],"scalar":{"value":4096.0},"type":"SCALAR"}]' and 0 operations from resource provider 4405065b-b461-466b-83a8-d1ea638000f7
I0409 03:42:26.913983 20157 slave.cpp:8177] Handling resource provider message 'UPDATE_STATE: 4405065b-b461-466b-83a8-d1ea638000f7 disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c,volume1,)]:4096'
I0409 03:42:26.914221 20157 slave.cpp:8297] Forwarding new total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c,volume1,)]:4096
I0409 03:42:26.918452 20166 hierarchical.cpp:783] Grew agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 by disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c,volume1,)]:4096 (total), { } (used)
I0409 03:42:26.919145 20166 hierarchical.cpp:740] Agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 (7ed09a2c5c07) updated with total resources cpus:2; mem:1024; disk:1024; ports:[31000-32000]; disk(reservations: [(DYNAMIC,storage)])[RAW(org.apache.mesos.csi.test.local_d22829ff8d444ede8e691c4ef415676c,volume1,)]:4096
I0409 03:42:26.920114 20152 process.cpp:3588] Handling HTTP event for process 'slave(1102)' with path: '/slave(1102)/api/v1'
I0409 03:42:26.921679 20169 http.cpp:1105] HTTP POST for /slave(1102)/api/v1 from 172.17.0.2:39864
I0409 03:42:26.923197 20169 http.cpp:3223] Processing ADD_RESOURCE_PROVIDER_CONFIG call with type 'org.apache.mesos.rp.local.storage' and name 'test'
I0409 03:42:26.927125 20145 slave.cpp:912] Agent terminating
I0409 03:42:26.928221 20145 manager.cpp:163] Terminating resource provider 4405065b-b461-466b-83a8-d1ea638000f7
I0409 03:42:26.928792 20160 master.cpp:1295] Agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07) disconnected
I0409 03:42:26.928863 20160 master.cpp:3333] Disconnecting agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:26.928979 20160 master.cpp:3352] Deactivating agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 at slave(1102)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:26.929162 20149 hierarchical.cpp:829] Agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0 deactivated
E0409 03:42:26.929497 20157 http_connection.hpp:452] End-Of-File received
I0409 03:42:26.930100 20157 http_connection.hpp:217] Re-detecting endpoint
I0409 03:42:26.930824 20157 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I0409 03:42:26.930924 20157 http_connection.hpp:338] Ignoring disconnection attempt from stale connection
I0409 03:42:26.931005 20163 provider.cpp:445] Disconnected from resource provider manager
I0409 03:42:26.931030 20157 http_connection.hpp:227] New endpoint detected at http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.931293 20168 status_update_manager_process.hpp:379] Pausing operation status update manager
I0409 03:42:26.932977 20151 containerizer.cpp:2576] Destroying container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE in RUNNING state
I0409 03:42:26.933063 20151 containerizer.cpp:3278] Transitioning the state of container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE from RUNNING to DESTROYING
I0409 03:42:26.933696 20151 launcher.cpp:161] Asked to destroy container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE
I0409 03:42:26.934698 20153 http_connection.hpp:283] Connected with the remote endpoint at http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.935428 20163 provider.cpp:433] Connected to resource provider manager
I0409 03:42:26.936245 20150 http_connection.hpp:131] Sending 1 call to http://172.17.0.2:40730/slave(1102)/api/v1/resource_provider
I0409 03:42:26.937338 20170 process.cpp:2754] Returning '404 Not Found' for '/slave(1102)/api/v1/resource_provider'
E0409 03:42:26.939221 20148 provider.cpp:656] Failed to subscribe resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test': Received '404 Not Found' ()
I0409 03:42:26.941320 20147 hierarchical.cpp:1595] Performed allocation for 1 agents in 193432ns
I0409 03:42:26.979001 20160 containerizer.cpp:3117] Container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE has exited
I0409 03:42:26.981134 20159 provisioner.cpp:597] Ignoring destroy request for unknown container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE
I0409 03:42:26.984174 20151 container_daemon.cpp:189] Invoking post-stop hook for container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.984444 20157 service_manager.cpp:718] Disconnected from endpoint 'unix:///tmp/mesos-csi-TdVh0V/endpoint.sock' of CSI plugin container org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE
I0409 03:42:26.984737 20146 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_d22829ff8d444ede8e691c4ef415676c--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:26.988111 20170 process.cpp:2754] Returning '404 Not Found' for '/slave(1102)/api/v1'
I0409 03:42:27.002619 20145 master.cpp:1135] Master terminating
I0409 03:42:27.003823 20149 hierarchical.cpp:680] Removed agent b9d0869a-05b1-4d1a-a172-669c2d8ca0c3-S0
[ OK ] ContentType/AgentResourceProviderConfigApiTest.IdempotentAdd/1 (899 ms)
[ RUN ] ContentType/AgentResourceProviderConfigApiTest.AddConflict/0
I0409 03:42:27.020196 20145 cluster.cpp:176] Creating default 'local' authorizer
I0409 03:42:27.025678 20152 master.cpp:440] Master d095dd76-b0e4-4597-95fa-9bb507f88253 (7ed09a2c5c07) started on 172.17.0.2:40730
I0409 03:42:27.025722 20152 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/k7czK4/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_allocatable_resources="cpus:0.01|mem:32" --port="5050" --publish_per_framework_metrics="true" --quiet="false" --recovery_agent_removal_limit="100%" --registry="in_memory" --registry_fetch_timeout="1mins" --registry_gc_interval="15mins" --registry_max_agent_age="2weeks" --registry_max_agent_count="102400" --registry_store_timeout="100secs" --registry_strict="false" --require_agent_domain="false" --role_sorter="drf" --root_submissions="true" --version="false" --webui_dir="/mesos/mesos-1.9.0/_inst/share/mesos/webui" --work_dir="/tmp/k7czK4/master" --zk_session_timeout="10secs"
I0409 03:42:27.026196 20152 master.cpp:492] Master only allowing authenticated frameworks to register
I0409 03:42:27.026217 20152 master.cpp:498] Master only allowing authenticated agents to register
I0409 03:42:27.026232 20152 master.cpp:504] Master only allowing authenticated HTTP frameworks to register
I0409 03:42:27.026245 20152 credentials.hpp:37] Loading credentials for authentication from '/tmp/k7czK4/credentials'
I0409 03:42:27.026618 20152 master.cpp:548] Using default 'crammd5' authenticator
I0409 03:42:27.026854 20152 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readonly'
I0409 03:42:27.027101 20152 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-master-readwrite'
I0409 03:42:27.027287 20152 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-master-scheduler'
I0409 03:42:27.027503 20152 master.cpp:629] Authorization enabled
I0409 03:42:27.027928 20166 hierarchical.cpp:210] Initialized hierarchical allocator process
I0409 03:42:27.027947 20159 whitelist_watcher.cpp:77] No whitelist given
I0409 03:42:27.031282 20157 master.cpp:2141] Elected as the leading master!
I0409 03:42:27.031327 20157 master.cpp:1664] Recovering from registrar
I0409 03:42:27.031574 20167 registrar.cpp:339] Recovering registrar
I0409 03:42:27.032438 20167 registrar.cpp:383] Successfully fetched the registry (0B) in 804096ns
I0409 03:42:27.032590 20167 registrar.cpp:487] Applied 1 operations in 42598ns; attempting to update the registry
I0409 03:42:27.033321 20167 registrar.cpp:544] Successfully updated the registry in 654848ns
I0409 03:42:27.033478 20167 registrar.cpp:416] Successfully recovered registrar
I0409 03:42:27.034015 20163 master.cpp:1790] Recovered 0 agents from the registry (135B); allowing 10mins for agents to reregister
I0409 03:42:27.034042 20155 hierarchical.cpp:250] Skipping recovery of hierarchical allocator: nothing to recover
W0409 03:42:27.042356 20145 process.cpp:2829] Attempted to spawn already running process files@172.17.0.2:40730
I0409 03:42:27.043741 20145 containerizer.cpp:314] Using isolation { environment_secret, posix/cpu, posix/mem, filesystem/posix, network/cni }
W0409 03:42:27.044356 20145 backend.cpp:76] Failed to create 'aufs' backend: AufsBackend requires root privileges
W0409 03:42:27.044507 20145 backend.cpp:76] Failed to create 'bind' backend: BindBackend requires root privileges
I0409 03:42:27.044560 20145 provisioner.cpp:298] Using default backend 'copy'
I0409 03:42:27.047214 20145 cluster.cpp:510] Creating default 'local' authorizer
I0409 03:42:27.049504 20163 slave.cpp:265] Mesos agent started on (1103)@172.17.0.2:40730
I0409 03:42:27.049535 20163 slave.cpp:266] Flags at startup: --acls="" --appc_simple_discovery_uri_prefix="http://" --appc_store_dir="/tmp/k7czK4/cJ6W4k/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/k7czK4/cJ6W4k/credential" --default_role="*" --disallow_sharing_agent_pid_namespace="false" --disk_watch_interval="1mins" --docker="docker" --docker_kill_orphans="true" --docker_registry="https://registry-1.docker.io" --docker_remove_delay="6hrs" --docker_socket="/var/run/docker.sock" --docker_stop_timeout="0ns" --docker_store_dir="/tmp/k7czK4/cJ6W4k/store/docker" --docker_volume_checkpoint_dir="/var/run/mesos/isolators/docker/volume" --enforce_container_disk_quota="false" --executor_registration_timeout="1mins" --executor_reregistration_timeout="2secs" --executor_shutdown_grace_period="5secs" --fetcher_cache_dir="/tmp/k7czK4/cJ6W4k/fetch" --fetcher_cache_size="2GB" --fetcher_stall_timeout="1mins" --frameworks_home="/tmp/k7czK4/cJ6W4k/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/k7czK4/cJ6W4k/http_credentials" --http_heartbeat_interval="30secs" --initialize_driver_logging="true" --isolation="posix/cpu,posix/mem" --launcher="posix" --launcher_dir="/mesos/mesos-1.9.0/_build/src" --logbufsecs="0" --logging_level="INFO" --max_completed_executors_per_framework="150" --memory_profiling="false" --network_cni_metrics="true" --network_cni_root_dir_persist="false" --oversubscribed_resources_interval="15secs" --perf_duration="10secs" --perf_interval="1mins" --port="5051" --qos_correction_interval_min="0ns" --quiet="false" --reconfiguration_policy="equal" --recover="reconnect" --recovery_timeout="15mins" --registration_backoff_factor="10ms" --resource_provider_config_dir="/tmp/k7czK4/resource_provider_configs" --resources="cpus:2;gpus:0;mem:1024;disk:1024;ports:[31000-32000]" --revocable_cpu_low_priority="true" --runtime_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddConflict_0_qQdOiA" --sandbox_directory="/mnt/mesos/sandbox" --strict="true" --switch_user="true" --systemd_enable_support="true" --systemd_runtime_directory="/run/systemd/system" --version="false" --work_dir="/tmp/ContentType_AgentResourceProviderConfigApiTest_AddConflict_0_EfdGwP" --zk_session_timeout="10secs"
I0409 03:42:27.050042 20163 credentials.hpp:86] Loading credential for authentication from '/tmp/k7czK4/cJ6W4k/credential'
I0409 03:42:27.050223 20163 slave.cpp:298] Agent using credential for: test-principal
I0409 03:42:27.050259 20163 credentials.hpp:37] Loading credentials for authentication from '/tmp/k7czK4/cJ6W4k/http_credentials'
I0409 03:42:27.050510 20163 http.cpp:965] Creating default 'basic' HTTP authenticator for realm 'mesos-agent-readonly'
I0409 03:42:27.050917 20163 disk_profile_adaptor.cpp:78] Creating default disk profile adaptor module
I0409 03:42:27.052428 20163 slave.cpp:613] 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"}]
I0409 03:42:27.052646 20163 slave.cpp:621] Agent attributes: [ ]
I0409 03:42:27.052664 20163 slave.cpp:630] Agent hostname: 7ed09a2c5c07
I0409 03:42:27.052913 20161 status_update_manager_process.hpp:379] Pausing operation status update manager
I0409 03:42:27.052914 20165 task_status_update_manager.cpp:181] Pausing sending task status updates
I0409 03:42:27.054425 20169 state.cpp:67] Recovering state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddConflict_0_EfdGwP/meta'
I0409 03:42:27.054689 20153 slave.cpp:7211] Finished recovering checkpointed state from '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddConflict_0_EfdGwP/meta', beginning agent recovery
I0409 03:42:27.055338 20162 task_status_update_manager.cpp:207] Recovering task status update manager
I0409 03:42:27.055824 20148 containerizer.cpp:797] Recovering Mesos containers
I0409 03:42:27.056216 20148 containerizer.cpp:1123] Recovering isolators
I0409 03:42:27.056968 20152 containerizer.cpp:1162] Recovering provisioner
I0409 03:42:27.057885 20161 provisioner.cpp:494] Provisioner recovery complete
I0409 03:42:27.058748 20150 composing.cpp:339] Finished recovering all containerizers
I0409 03:42:27.059069 20168 slave.cpp:7668] Recovering executors
I0409 03:42:27.059195 20168 slave.cpp:7821] Finished recovery
I0409 03:42:27.060089 20155 task_status_update_manager.cpp:181] Pausing sending task status updates
I0409 03:42:27.060145 20160 slave.cpp:1258] New master detected at master@172.17.0.2:40730
I0409 03:42:27.060168 20158 status_update_manager_process.hpp:379] Pausing operation status update manager
I0409 03:42:27.060274 20160 slave.cpp:1323] Detecting new master
I0409 03:42:27.062714 20159 slave.cpp:1350] Authenticating with master master@172.17.0.2:40730
I0409 03:42:27.062793 20159 slave.cpp:1359] Using default CRAM-MD5 authenticatee
I0409 03:42:27.063128 20148 authenticatee.cpp:121] Creating new client SASL connection
I0409 03:42:27.063482 20157 master.cpp:10192] Authenticating slave(1103)@172.17.0.2:40730
I0409 03:42:27.063681 20152 authenticator.cpp:414] Starting authentication session for crammd5-authenticatee(1906)@172.17.0.2:40730
I0409 03:42:27.064121 20151 authenticator.cpp:98] Creating new server SASL connection
I0409 03:42:27.064483 20165 authenticatee.cpp:213] Received SASL authentication mechanisms: CRAM-MD5
I0409 03:42:27.064525 20165 authenticatee.cpp:239] Attempting to authenticate with mechanism 'CRAM-MD5'
I0409 03:42:27.064685 20161 authenticator.cpp:204] Received SASL authentication start
I0409 03:42:27.064779 20161 authenticator.cpp:326] Authentication requires more steps
I0409 03:42:27.064960 20154 authenticatee.cpp:259] Received SASL authentication step
I0409 03:42:27.065155 20146 authenticator.cpp:232] Received SASL authentication step
I0409 03:42:27.065202 20146 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7ed09a2c5c07' server FQDN: '7ed09a2c5c07' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: false
I0409 03:42:27.065225 20146 auxprop.cpp:181] Looking up auxiliary property '*userPassword'
I0409 03:42:27.065279 20146 auxprop.cpp:181] Looking up auxiliary property '*cmusaslsecretCRAM-MD5'
I0409 03:42:27.065310 20146 auxprop.cpp:109] Request to lookup properties for user: 'test-principal' realm: '7ed09a2c5c07' server FQDN: '7ed09a2c5c07' SASL_AUXPROP_VERIFY_AGAINST_HASH: false SASL_AUXPROP_OVERRIDE: false SASL_AUXPROP_AUTHZID: true
I0409 03:42:27.065330 20146 auxprop.cpp:131] Skipping auxiliary property '*userPassword' since SASL_AUXPROP_AUTHZID == true
I0409 03:42:27.065346 20146 auxprop.cpp:131] Skipping auxiliary property '*cmusaslsecretCRAM-MD5' since SASL_AUXPROP_AUTHZID == true
I0409 03:42:27.065372 20146 authenticator.cpp:318] Authentication success
I0409 03:42:27.065487 20163 authenticatee.cpp:299] Authentication success
I0409 03:42:27.065645 20149 master.cpp:10224] Successfully authenticated principal 'test-principal' at slave(1103)@172.17.0.2:40730
I0409 03:42:27.065693 20153 authenticator.cpp:432] Authentication session cleanup for crammd5-authenticatee(1906)@172.17.0.2:40730
I0409 03:42:27.065896 20169 slave.cpp:1450] Successfully authenticated with master master@172.17.0.2:40730
I0409 03:42:27.066267 20169 slave.cpp:1897] Will retry registration in 17.623607ms if necessary
I0409 03:42:27.066462 20156 master.cpp:6821] Received register agent message from slave(1103)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:27.066762 20156 master.cpp:4053] Authorizing agent providing resources 'cpus:2; mem:1024; disk:1024; ports:[31000-32000]' with principal 'test-principal'
I0409 03:42:27.067416 20160 master.cpp:6888] Authorized registration of agent at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:27.067533 20160 master.cpp:7003] Registering agent at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07) with id d095dd76-b0e4-4597-95fa-9bb507f88253-S0
I0409 03:42:27.068125 20166 registrar.cpp:487] Applied 1 operations in 175676ns; attempting to update the registry
I0409 03:42:27.068761 20166 registrar.cpp:544] Successfully updated the registry in 566016ns
I0409 03:42:27.069005 20151 master.cpp:7051] Admitted agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:27.069736 20151 master.cpp:7096] Registered agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07) with cpus:2; mem:1024; disk:1024; ports:[31000-32000]
I0409 03:42:27.069936 20154 hierarchical.cpp:640] Added agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 (7ed09a2c5c07) with cpus:2; mem:1024; disk:1024; ports:[31000-32000] (allocated: {})
I0409 03:42:27.070034 20161 slave.cpp:1483] Registered with master master@172.17.0.2:40730; given agent ID d095dd76-b0e4-4597-95fa-9bb507f88253-S0
I0409 03:42:27.070248 20163 task_status_update_manager.cpp:188] Resuming sending task status updates
I0409 03:42:27.070359 20154 hierarchical.cpp:1595] Performed allocation for 1 agents in 154592ns
I0409 03:42:27.070669 20161 slave.cpp:1518] Checkpointing SlaveInfo to '/tmp/ContentType_AgentResourceProviderConfigApiTest_AddConflict_0_EfdGwP/meta/slaves/d095dd76-b0e4-4597-95fa-9bb507f88253-S0/slave.info'
I0409 03:42:27.070732 20167 status_update_manager_process.hpp:385] Resuming operation status update manager
I0409 03:42:27.072389 20161 slave.cpp:1567] Forwarding agent update {"operations":{},"resource_providers":{},"resource_version_uuid":{"value":"B1frVEn6Qh6EJieQLNZZ+g=="},"slave_id":{"value":"d095dd76-b0e4-4597-95fa-9bb507f88253-S0"},"update_oversubscribed_resources":false}
I0409 03:42:27.073107 20158 master.cpp:8174] Ignoring update on agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07) as it reports no changes
I0409 03:42:27.075165 20162 process.cpp:3588] Handling HTTP event for process 'slave(1103)' with path: '/slave(1103)/api/v1'
I0409 03:42:27.076406 20147 http.cpp:1105] HTTP POST for /slave(1103)/api/v1 from 172.17.0.2:39872
I0409 03:42:27.077523 20147 http.cpp:3223] Processing ADD_RESOURCE_PROVIDER_CONFIG call with type 'org.apache.mesos.rp.local.storage' and name 'test'
I0409 03:42:27.078840 20152 process.cpp:3588] Handling HTTP event for process 'slave(1103)' with path: '/slave(1103)/api/v1'
I0409 03:42:27.079674 20163 http.cpp:1105] HTTP POST for /slave(1103)/api/v1 from 172.17.0.2:39874
I0409 03:42:27.079804 20165 hierarchical.cpp:1595] Performed allocation for 1 agents in 113827ns
I0409 03:42:27.080103 20163 http.cpp:2113] Processing GET_CONTAINERS call
I0409 03:42:27.082379 20159 slave.cpp:912] Agent terminating
I0409 03:42:27.086979 20162 container_daemon.cpp:121] Launching container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_9c86228eeef7429c957edcaf312b8a59--CONTROLLER_SERVICE-NODE_SERVICE'
I0409 03:42:27.131222 20157 hierarchical.cpp:1595] Performed allocation for 1 agents in 102993ns
I0409 03:42:27.182261 20147 hierarchical.cpp:1595] Performed allocation for 1 agents in 229867ns
I0409 03:42:27.233526 20164 hierarchical.cpp:1595] Performed allocation for 1 agents in 162458ns
I0409 03:42:27.247870 20150 master.cpp:1295] Agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07) disconnected
I0409 03:42:27.247936 20150 master.cpp:3333] Disconnecting agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:27.248028 20150 master.cpp:3352] Deactivating agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 at slave(1103)@172.17.0.2:40730 (7ed09a2c5c07)
I0409 03:42:27.248189 20149 hierarchical.cpp:829] Agent d095dd76-b0e4-4597-95fa-9bb507f88253-S0 deactivated
E0409 03:42:27.249423 20155 container_daemon.cpp:150] Failed to launch container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_9c86228eeef7429c957edcaf312b8a59--CONTROLLER_SERVICE-NODE_SERVICE': Failed to launch container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_9c86228eeef7429c957edcaf312b8a59--CONTROLLER_SERVICE-NODE_SERVICE': Unexpected response '500 Internal Server Error' (500 Internal Server Error.)
E0409 03:42:27.249676 20162 service_manager.cpp:746] Container daemon for 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_9c86228eeef7429c957edcaf312b8a59--CONTROLLER_SERVICE-NODE_SERVICE' failed: Failed to launch container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_9c86228eeef7429c957edcaf312b8a59--CONTROLLER_SERVICE-NODE_SERVICE': Unexpected response '500 Internal Server Error' (500 Internal Server Error.)
E0409 03:42:27.250355 20162 process.cpp:3968]
**** DEADLOCK DETECTED! ****
You are waiting on process csi-service-manager(29)@172.17.0.2:40730 that it is currently executing.
E0409 03:42:27.250362 20163 provider.cpp:498] Failed to recover resource provider with type 'org.apache.mesos.rp.local.storage' and name 'test': Failed to launch container 'org-apache-mesos-rp-local-storage-test--org-apache-mesos-csi-test-local_9c86228eeef7429c957edcaf312b8a59--CONTROLLER_SERVICE-NODE_SERVICE': Unexpected response '500 Internal Server Error' (500 Internal Server Error.)
Build timed out (after 240 minutes). Marking the build as failed.
Build was aborted
Jenkins build is back to normal : Mesos-Reviewbot-Linux #717
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/Mesos-Reviewbot-Linux/717/display/redirect>