This job view page is being replaced by Spyglass soon. Check out the new job view.
Resultsuccess
Tests 0 failed / 12 succeeded
Started2022-09-06 23:46
Elapsed47m8s
Revision
uploadercrier

No Test Failures!


Show 12 Passed Tests

Show 47 Skipped Tests

Error lines from build-log.txt

... skipping 702 lines ...
certificate.cert-manager.io "selfsigned-cert" deleted
# Create secret for AzureClusterIdentity
./hack/create-identity-secret.sh
make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure'
make[2]: Nothing to be done for 'kubectl'.
make[2]: Leaving directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure'
Error from server (NotFound): secrets "cluster-identity-secret" not found
secret/cluster-identity-secret created
secret/cluster-identity-secret labeled
# Create customized cloud provider configs
./hack/create-custom-cloud-provider-config.sh
make[2]: Entering directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure'
make[2]: Nothing to be done for 'kubectl'.
... skipping 134 lines ...
# Wait for the kubeconfig to become available.
timeout --foreground 300 bash -c "while ! /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/hack/tools/bin/kubectl-v1.22.4 get secrets | grep capz-nlyx1d-kubeconfig; do sleep 1; done"
capz-nlyx1d-kubeconfig                 cluster.x-k8s.io/secret   1      0s
# Get kubeconfig and store it locally.
/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/hack/tools/bin/kubectl-v1.22.4 get secrets capz-nlyx1d-kubeconfig -o json | jq -r .data.value | base64 --decode > ./kubeconfig
timeout --foreground 600 bash -c "while ! /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/hack/tools/bin/kubectl-v1.22.4 --kubeconfig=./kubeconfig get nodes | grep control-plane; do sleep 1; done"
error: the server doesn't have a resource type "nodes"
capz-nlyx1d-control-plane-jp9jl   NotReady   control-plane   5s    v1.26.0-alpha.0.389+ed967343f4a035
run "/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/hack/tools/bin/kubectl-v1.22.4 --kubeconfig=./kubeconfig ..." to work with the new target cluster
make[1]: Leaving directory '/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure'
Waiting for 1 control plane machine(s), 2 worker machine(s), and  windows machine(s) to become Ready
node/capz-nlyx1d-control-plane-jp9jl condition met
node/capz-nlyx1d-mp-0000000 condition met
... skipping 62 lines ...
Dynamic Provisioning [single-az] 
  should create a volume on demand with mount options [kubernetes.io/azure-disk] [disk.csi.azure.com] [Windows]
  /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/dynamic_provisioning_test.go:101
STEP: Creating a kubernetes client
Sep  7 00:00:31.374: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig
STEP: Building a namespace api object, basename azuredisk
Sep  7 00:00:31.647: INFO: Error listing PodSecurityPolicies; assuming PodSecurityPolicy is disabled: the server could not find the requested resource
STEP: Waiting for a default service account to be provisioned in namespace
STEP: Waiting for kube-root-ca.crt to be provisioned in namespace
2022/09/07 00:00:31 Check driver pods if restarts ...
check the driver pods if restarts ...
======================================================================================
2022/09/07 00:00:32 Check successfully
Sep  7 00:00:32.184: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig
STEP: setting up the StorageClass
STEP: creating a StorageClass 
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  7 00:00:32.304: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-8dvgg" in namespace "azuredisk-8081" to be "Succeeded or Failed"
Sep  7 00:00:32.335: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 30.442373ms
Sep  7 00:00:34.367: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 2.063204131s
Sep  7 00:00:36.399: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 4.094857944s
Sep  7 00:00:38.431: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 6.126421968s
Sep  7 00:00:40.463: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 8.158225737s
Sep  7 00:00:42.494: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 10.189345671s
... skipping 3 lines ...
Sep  7 00:00:50.631: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 18.326444672s
Sep  7 00:00:52.665: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Pending", Reason="", readiness=false. Elapsed: 20.360550642s
Sep  7 00:00:54.698: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Running", Reason="", readiness=true. Elapsed: 22.394007324s
Sep  7 00:00:56.733: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Running", Reason="", readiness=false. Elapsed: 24.428675023s
Sep  7 00:00:58.767: INFO: Pod "azuredisk-volume-tester-8dvgg": Phase="Succeeded", Reason="", readiness=false. Elapsed: 26.462880491s
STEP: Saw pod success
Sep  7 00:00:58.767: INFO: Pod "azuredisk-volume-tester-8dvgg" satisfied condition "Succeeded or Failed"
Sep  7 00:00:58.767: INFO: deleting Pod "azuredisk-8081"/"azuredisk-volume-tester-8dvgg"
Sep  7 00:00:58.812: INFO: Pod azuredisk-volume-tester-8dvgg has the following logs: hello world

STEP: Deleting pod azuredisk-volume-tester-8dvgg in namespace azuredisk-8081
STEP: validating provisioned PV
STEP: checking the PV
... skipping 97 lines ...
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod has 'FailedMount' event
Sep  7 00:01:54.108: INFO: deleting Pod "azuredisk-5466"/"azuredisk-volume-tester-8lcvr"
Sep  7 00:01:54.153: INFO: Error getting logs for pod azuredisk-volume-tester-8lcvr: the server rejected our request for an unknown reason (get pods azuredisk-volume-tester-8lcvr)
STEP: Deleting pod azuredisk-volume-tester-8lcvr in namespace azuredisk-5466
STEP: validating provisioned PV
STEP: checking the PV
Sep  7 00:01:54.248: INFO: deleting PVC "azuredisk-5466"/"pvc-8tt77"
Sep  7 00:01:54.248: INFO: Deleting PersistentVolumeClaim "pvc-8tt77"
STEP: waiting for claim's PV "pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6" to be deleted
... skipping 58 lines ...
STEP: setting up the StorageClass
STEP: creating a StorageClass 
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  7 00:04:21.035: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-6tghl" in namespace "azuredisk-2790" to be "Succeeded or Failed"
Sep  7 00:04:21.065: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 30.00575ms
Sep  7 00:04:23.096: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 2.061171385s
Sep  7 00:04:25.128: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 4.092736457s
Sep  7 00:04:27.160: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 6.124965176s
Sep  7 00:04:29.192: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 8.156716483s
Sep  7 00:04:31.224: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 10.188953945s
Sep  7 00:04:33.256: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 12.221075577s
Sep  7 00:04:35.288: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 14.25353201s
Sep  7 00:04:37.321: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 16.285968272s
Sep  7 00:04:39.353: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 18.318584157s
Sep  7 00:04:41.386: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Pending", Reason="", readiness=false. Elapsed: 20.350674905s
Sep  7 00:04:43.419: INFO: Pod "azuredisk-volume-tester-6tghl": Phase="Succeeded", Reason="", readiness=false. Elapsed: 22.384515024s
STEP: Saw pod success
Sep  7 00:04:43.419: INFO: Pod "azuredisk-volume-tester-6tghl" satisfied condition "Succeeded or Failed"
Sep  7 00:04:43.419: INFO: deleting Pod "azuredisk-2790"/"azuredisk-volume-tester-6tghl"
Sep  7 00:04:43.464: INFO: Pod azuredisk-volume-tester-6tghl has the following logs: e2e-test

STEP: Deleting pod azuredisk-volume-tester-6tghl in namespace azuredisk-2790
STEP: validating provisioned PV
STEP: checking the PV
... skipping 39 lines ...
STEP: setting up the StorageClass
STEP: creating a StorageClass 
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with an error
Sep  7 00:05:19.584: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-88hf9" in namespace "azuredisk-5356" to be "Error status code"
Sep  7 00:05:19.614: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 30.339153ms
Sep  7 00:05:21.648: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 2.063748099s
Sep  7 00:05:23.679: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 4.095407955s
Sep  7 00:05:25.711: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 6.126856543s
Sep  7 00:05:27.745: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 8.161494637s
Sep  7 00:05:29.777: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 10.192890669s
Sep  7 00:05:31.809: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 12.225466298s
Sep  7 00:05:33.841: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 14.257097088s
Sep  7 00:05:35.873: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 16.28942429s
Sep  7 00:05:37.905: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 18.32120554s
Sep  7 00:05:39.937: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 20.353610798s
Sep  7 00:05:41.971: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 22.386746529s
Sep  7 00:05:44.003: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Pending", Reason="", readiness=false. Elapsed: 24.41955169s
Sep  7 00:05:46.037: INFO: Pod "azuredisk-volume-tester-88hf9": Phase="Failed", Reason="", readiness=false. Elapsed: 26.45299588s
STEP: Saw pod failure
Sep  7 00:05:46.037: INFO: Pod "azuredisk-volume-tester-88hf9" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Sep  7 00:05:46.079: INFO: deleting Pod "azuredisk-5356"/"azuredisk-volume-tester-88hf9"
Sep  7 00:05:46.112: INFO: Pod azuredisk-volume-tester-88hf9 has the following logs: touch: /mnt/test-1/data: Read-only file system

STEP: Deleting pod azuredisk-volume-tester-88hf9 in namespace azuredisk-5356
STEP: validating provisioned PV
... skipping 379 lines ...
STEP: setting up the StorageClass
STEP: creating a StorageClass 
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  7 00:13:34.748: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-kxg86" in namespace "azuredisk-59" to be "Succeeded or Failed"
Sep  7 00:13:34.789: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 41.419605ms
Sep  7 00:13:36.822: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 2.074232537s
Sep  7 00:13:38.856: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 4.108781158s
Sep  7 00:13:40.890: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 6.142700496s
Sep  7 00:13:42.925: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 8.177448651s
Sep  7 00:13:44.959: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 10.211419798s
... skipping 6 lines ...
Sep  7 00:13:59.196: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 24.448740169s
Sep  7 00:14:01.229: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 26.481182474s
Sep  7 00:14:03.262: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 28.514794291s
Sep  7 00:14:05.298: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Pending", Reason="", readiness=false. Elapsed: 30.550403678s
Sep  7 00:14:07.332: INFO: Pod "azuredisk-volume-tester-kxg86": Phase="Succeeded", Reason="", readiness=false. Elapsed: 32.584431723s
STEP: Saw pod success
Sep  7 00:14:07.333: INFO: Pod "azuredisk-volume-tester-kxg86" satisfied condition "Succeeded or Failed"
Sep  7 00:14:07.333: INFO: deleting Pod "azuredisk-59"/"azuredisk-volume-tester-kxg86"
Sep  7 00:14:07.377: INFO: Pod azuredisk-volume-tester-kxg86 has the following logs: hello world
hello world
hello world

STEP: Deleting pod azuredisk-volume-tester-kxg86 in namespace azuredisk-59
... skipping 81 lines ...
STEP: setting up the StorageClass
STEP: creating a StorageClass 
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: setting up the pod
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  7 00:15:59.495: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-grlgw" in namespace "azuredisk-2546" to be "Succeeded or Failed"
Sep  7 00:15:59.538: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 42.436799ms
Sep  7 00:16:01.569: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 2.073413154s
Sep  7 00:16:03.600: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 4.10494659s
Sep  7 00:16:05.631: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 6.136143254s
Sep  7 00:16:07.666: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 8.170783653s
Sep  7 00:16:09.698: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 10.202923579s
... skipping 5 lines ...
Sep  7 00:16:21.893: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 22.398115117s
Sep  7 00:16:23.926: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 24.430721677s
Sep  7 00:16:25.958: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 26.46283836s
Sep  7 00:16:27.991: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Pending", Reason="", readiness=false. Elapsed: 28.495696349s
Sep  7 00:16:30.024: INFO: Pod "azuredisk-volume-tester-grlgw": Phase="Succeeded", Reason="", readiness=false. Elapsed: 30.528987421s
STEP: Saw pod success
Sep  7 00:16:30.024: INFO: Pod "azuredisk-volume-tester-grlgw" satisfied condition "Succeeded or Failed"
Sep  7 00:16:30.024: INFO: deleting Pod "azuredisk-2546"/"azuredisk-volume-tester-grlgw"
Sep  7 00:16:30.071: INFO: Pod azuredisk-volume-tester-grlgw has the following logs: 100+0 records in
100+0 records out
104857600 bytes (100.0MB) copied, 0.066393 seconds, 1.5GB/s
hello world

... skipping 116 lines ...
STEP: creating a PVC
STEP: setting up the StorageClass
STEP: creating a StorageClass 
STEP: setting up the PVC and PV
STEP: creating a PVC
STEP: deploying the pod
STEP: checking that the pod's command exits with no error
Sep  7 00:17:12.673: INFO: Waiting up to 15m0s for pod "azuredisk-volume-tester-nzq8j" in namespace "azuredisk-8582" to be "Succeeded or Failed"
Sep  7 00:17:12.706: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 33.12084ms
Sep  7 00:17:14.737: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 2.064020598s
Sep  7 00:17:16.773: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 4.099730347s
Sep  7 00:17:18.807: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 6.133722039s
Sep  7 00:17:20.840: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 8.166957559s
Sep  7 00:17:22.874: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 10.200338906s
... skipping 7 lines ...
Sep  7 00:17:39.138: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 26.464281567s
Sep  7 00:17:41.171: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 28.49780488s
Sep  7 00:17:43.204: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 30.531208219s
Sep  7 00:17:45.238: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Pending", Reason="", readiness=false. Elapsed: 32.564301113s
Sep  7 00:17:47.272: INFO: Pod "azuredisk-volume-tester-nzq8j": Phase="Succeeded", Reason="", readiness=false. Elapsed: 34.598443943s
STEP: Saw pod success
Sep  7 00:17:47.272: INFO: Pod "azuredisk-volume-tester-nzq8j" satisfied condition "Succeeded or Failed"
Sep  7 00:17:47.272: INFO: deleting Pod "azuredisk-8582"/"azuredisk-volume-tester-nzq8j"
Sep  7 00:17:47.317: INFO: Pod azuredisk-volume-tester-nzq8j has the following logs: hello world

STEP: Deleting pod azuredisk-volume-tester-nzq8j in namespace azuredisk-8582
STEP: validating provisioned PV
STEP: checking the PV
... skipping 424 lines ...

    test case is only available for CSI drivers

    /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/suite_test.go:304
------------------------------
Pre-Provisioned [single-az] 
  should fail when maxShares is invalid [disk.csi.azure.com][windows]
  /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:163
STEP: Creating a kubernetes client
Sep  7 00:21:57.078: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig
STEP: Building a namespace api object, basename azuredisk
STEP: Waiting for a default service account to be provisioned in namespace
STEP: Waiting for kube-root-ca.crt to be provisioned in namespace
... skipping 3 lines ...

S [SKIPPING] [0.292 seconds]
Pre-Provisioned
/home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:37
  [single-az]
  /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:69
    should fail when maxShares is invalid [disk.csi.azure.com][windows] [It]
    /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/pre_provisioning_test.go:163

    test case is only available for CSI drivers

    /home/prow/go/src/sigs.k8s.io/azuredisk-csi-driver/test/e2e/suite_test.go:304
------------------------------
... skipping 242 lines ...
I0906 23:56:08.809372       1 tlsconfig.go:200] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1662508568\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1662508568\" (2022-09-06 22:56:07 +0000 UTC to 2023-09-06 22:56:07 +0000 UTC (now=2022-09-06 23:56:08.809345721 +0000 UTC))"
I0906 23:56:08.809556       1 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1662508568\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1662508568\" (2022-09-06 22:56:08 +0000 UTC to 2023-09-06 22:56:08 +0000 UTC (now=2022-09-06 23:56:08.809528422 +0000 UTC))"
I0906 23:56:08.809592       1 secure_serving.go:210] Serving securely on 127.0.0.1:10257
I0906 23:56:08.809833       1 leaderelection.go:248] attempting to acquire leader lease kube-system/kube-controller-manager...
I0906 23:56:08.810744       1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I0906 23:56:08.810889       1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt"
E0906 23:56:12.924511       1 leaderelection.go:330] error retrieving resource lock kube-system/kube-controller-manager: leases.coordination.k8s.io "kube-controller-manager" is forbidden: User "system:kube-controller-manager" cannot get resource "leases" in API group "coordination.k8s.io" in the namespace "kube-system"
I0906 23:56:12.924749       1 leaderelection.go:253] failed to acquire lease kube-system/kube-controller-manager
I0906 23:56:16.137566       1 leaderelection.go:258] successfully acquired lease kube-system/kube-controller-manager
I0906 23:56:16.138144       1 event.go:294] "Event occurred" object="kube-system/kube-controller-manager" fieldPath="" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="capz-nlyx1d-control-plane-jp9jl_55b312aa-c394-447a-8441-93714f178694 became leader"
W0906 23:56:16.202084       1 plugins.go:131] WARNING: azure built-in cloud provider is now deprecated. The Azure provider is deprecated and will be removed in a future release. Please use https://github.com/kubernetes-sigs/cloud-provider-azure
I0906 23:56:16.203468       1 azure_auth.go:232] Using AzurePublicCloud environment
I0906 23:56:16.204177       1 azure_auth.go:117] azure: using client_id+client_secret to retrieve access token
I0906 23:56:16.204343       1 azure_interfaceclient.go:63] Azure InterfacesClient (read ops) using rate limit config: QPS=1, bucket=5
... skipping 29 lines ...
I0906 23:56:16.206373       1 reflector.go:221] Starting reflector *v1.Node (16h14m58.947354994s) from vendor/k8s.io/client-go/informers/factory.go:134
I0906 23:56:16.206397       1 reflector.go:257] Listing and watching *v1.Node from vendor/k8s.io/client-go/informers/factory.go:134
I0906 23:56:16.206795       1 reflector.go:221] Starting reflector *v1.ServiceAccount (16h14m58.947354994s) from vendor/k8s.io/client-go/informers/factory.go:134
I0906 23:56:16.207529       1 reflector.go:257] Listing and watching *v1.ServiceAccount from vendor/k8s.io/client-go/informers/factory.go:134
I0906 23:56:16.207156       1 reflector.go:221] Starting reflector *v1.Secret (16h14m58.947354994s) from vendor/k8s.io/client-go/informers/factory.go:134
I0906 23:56:16.208176       1 reflector.go:257] Listing and watching *v1.Secret from vendor/k8s.io/client-go/informers/factory.go:134
W0906 23:56:16.231880       1 azure_config.go:53] Failed to get cloud-config from secret: failed to get secret azure-cloud-provider: secrets "azure-cloud-provider" is forbidden: User "system:serviceaccount:kube-system:azure-cloud-provider" cannot get resource "secrets" in API group "" in the namespace "kube-system", skip initializing from secret
I0906 23:56:16.232021       1 controllermanager.go:573] Starting "replicationcontroller"
I0906 23:56:16.247202       1 controllermanager.go:602] Started "replicationcontroller"
I0906 23:56:16.247234       1 controllermanager.go:573] Starting "garbagecollector"
I0906 23:56:16.247657       1 replica_set.go:205] Starting replicationcontroller controller
I0906 23:56:16.247682       1 shared_informer.go:255] Waiting for caches to sync for ReplicationController
I0906 23:56:16.268320       1 garbagecollector.go:154] Starting garbage collector controller
... skipping 164 lines ...
I0906 23:56:18.511011       1 endpointslicemirroring_controller.go:216] Starting EndpointSliceMirroring controller
I0906 23:56:18.511471       1 shared_informer.go:255] Waiting for caches to sync for endpoint_slice_mirroring
I0906 23:56:18.559741       1 controllermanager.go:602] Started "csrapproving"
I0906 23:56:18.559778       1 controllermanager.go:573] Starting "statefulset"
I0906 23:56:18.559987       1 certificate_controller.go:112] Starting certificate controller "csrapproving"
I0906 23:56:18.560103       1 shared_informer.go:255] Waiting for caches to sync for certificate-csrapproving
I0906 23:56:18.635685       1 topologycache.go:183] Ignoring node capz-nlyx1d-control-plane-jp9jl because it is not ready: [{MemoryPressure False 2022-09-06 23:55:58 +0000 UTC 2022-09-06 23:55:58 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-06 23:55:58 +0000 UTC 2022-09-06 23:55:58 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-06 23:55:58 +0000 UTC 2022-09-06 23:55:58 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-06 23:55:58 +0000 UTC 2022-09-06 23:55:58 +0000 UTC KubeletNotReady [container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful, container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized, CSINode is not yet initialized]}]
I0906 23:56:18.635766       1 topologycache.go:215] Insufficient node info for topology hints (0 zones, %!s(int64=0) CPU, true)
I0906 23:56:18.706210       1 request.go:614] Waited for 62.345271ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/api/v1/namespaces/kube-system/serviceaccounts/ttl-controller
I0906 23:56:18.755975       1 request.go:614] Waited for 73.55522ms due to client-side throttling, not priority and fairness, request: POST:https://10.0.0.4:6443/api/v1/namespaces/kube-system/serviceaccounts
I0906 23:56:18.759369       1 controllermanager.go:602] Started "statefulset"
I0906 23:56:18.759399       1 controllermanager.go:573] Starting "cloud-node-lifecycle"
I0906 23:56:18.759793       1 stateful_set.go:152] Starting stateful set controller
... skipping 11 lines ...
I0906 23:56:19.012545       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/azure-disk"
I0906 23:56:19.012758       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/vsphere-volume"
I0906 23:56:19.012972       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/portworx-volume"
I0906 23:56:19.013032       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/rbd"
I0906 23:56:19.013081       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/fc"
I0906 23:56:19.013113       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/iscsi"
I0906 23:56:19.013181       1 csi_plugin.go:257] Cast from VolumeHost to KubeletVolumeHost failed. Skipping CSINode initialization, not running on kubelet
I0906 23:56:19.013259       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/csi"
I0906 23:56:19.013421       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-control-plane-jp9jl"
W0906 23:56:19.013453       1 actual_state_of_world.go:541] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="capz-nlyx1d-control-plane-jp9jl" does not exist
I0906 23:56:19.013512       1 controllermanager.go:602] Started "attachdetach"
I0906 23:56:19.013537       1 controllermanager.go:573] Starting "ephemeral-volume"
I0906 23:56:19.013953       1 attach_detach_controller.go:328] Starting attach detach controller
I0906 23:56:19.013981       1 shared_informer.go:255] Waiting for caches to sync for attach detach
I0906 23:56:19.160377       1 controllermanager.go:602] Started "ephemeral-volume"
I0906 23:56:19.160411       1 controllermanager.go:573] Starting "service"
... skipping 15 lines ...
I0906 23:56:19.474279       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/azure-disk"
I0906 23:56:19.474331       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/vsphere-volume"
I0906 23:56:19.474362       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/portworx-volume"
I0906 23:56:19.474413       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/rbd"
I0906 23:56:19.474436       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/azure-file"
I0906 23:56:19.474451       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/local-volume"
I0906 23:56:19.474506       1 csi_plugin.go:257] Cast from VolumeHost to KubeletVolumeHost failed. Skipping CSINode initialization, not running on kubelet
I0906 23:56:19.474520       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/csi"
I0906 23:56:19.474686       1 controllermanager.go:602] Started "persistentvolume-binder"
I0906 23:56:19.474878       1 controllermanager.go:573] Starting "clusterrole-aggregation"
I0906 23:56:19.474831       1 pv_controller_base.go:318] Starting persistent volume controller
I0906 23:56:19.475016       1 shared_informer.go:255] Waiting for caches to sync for persistent volume
I0906 23:56:19.610876       1 controllermanager.go:602] Started "clusterrole-aggregation"
... skipping 346 lines ...
I0906 23:56:22.753072       1 endpointslice_controller.go:319] Finished syncing service "kube-system/kube-dns" endpoint slices. (47.423481ms)
I0906 23:56:22.753287       1 endpointslicemirroring_controller.go:278] syncEndpoints("kube-system/kube-dns")
I0906 23:56:22.753307       1 endpointslicemirroring_controller.go:313] kube-system/kube-dns Service now has selector, cleaning up any mirrored EndpointSlices
I0906 23:56:22.753330       1 endpointslicemirroring_controller.go:275] Finished syncing EndpointSlices for "kube-system/kube-dns" Endpoints. (44.9µs)
I0906 23:56:22.770562       1 controller_utils.go:581] Controller coredns-84994b8c4 created pod coredns-84994b8c4-9w5x7
I0906 23:56:22.770939       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/coredns" duration="88.995452ms"
I0906 23:56:22.770969       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/coredns" err="Operation cannot be fulfilled on deployments.apps \"coredns\": the object has been modified; please apply your changes to the latest version and try again"
I0906 23:56:22.771006       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/coredns" startTime="2022-09-06 23:56:22.770990413 +0000 UTC m=+15.385302884"
I0906 23:56:22.771831       1 deployment_util.go:775] Deployment "coredns" timed out (false) [last progress check: 2022-09-06 23:56:22 +0000 UTC - now: 2022-09-06 23:56:22.771822214 +0000 UTC m=+15.386134685]
I0906 23:56:22.775372       1 event.go:294] "Event occurred" object="kube-system/coredns-84994b8c4" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-84994b8c4-9w5x7"
I0906 23:56:22.775689       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/coredns-84994b8c4-9w5x7"
I0906 23:56:22.775715       1 disruption.go:479] addPod called on pod "coredns-84994b8c4-9w5x7"
I0906 23:56:22.775735       1 disruption.go:570] No PodDisruptionBudgets found for pod coredns-84994b8c4-9w5x7, PodDisruptionBudget controller will avoid syncing.
... skipping 268 lines ...
I0906 23:56:37.154314       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/calico-kube-controllers"
I0906 23:56:37.154326       1 disruption.go:448] add DB "calico-kube-controllers"
I0906 23:56:37.158681       1 event.go:294] "Event occurred" object="kube-system/calico-kube-controllers-755ff8d7b5" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: calico-kube-controllers-755ff8d7b5-78cgz"
I0906 23:56:37.160710       1 disruption.go:484] addPod "calico-kube-controllers-755ff8d7b5-78cgz" -> PDB "calico-kube-controllers"
I0906 23:56:37.161509       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-kube-controllers-755ff8d7b5", timestamp:time.Time{wall:0xc0be156d463480c6, ext:29718416605, loc:(*time.Location)(0x6f10040)}}
I0906 23:56:37.167655       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/calico-kube-controllers" duration="79.020668ms"
I0906 23:56:37.168891       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/calico-kube-controllers" err="Operation cannot be fulfilled on deployments.apps \"calico-kube-controllers\": the object has been modified; please apply your changes to the latest version and try again"
I0906 23:56:37.168937       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/calico-kube-controllers" startTime="2022-09-06 23:56:37.168922619 +0000 UTC m=+29.783234990"
I0906 23:56:37.169148       1 disruption.go:494] updatePod called on pod "calico-kube-controllers-755ff8d7b5-78cgz"
I0906 23:56:37.169227       1 disruption.go:499] updatePod "calico-kube-controllers-755ff8d7b5-78cgz" -> PDB "calico-kube-controllers"
I0906 23:56:37.169973       1 deployment_util.go:775] Deployment "calico-kube-controllers" timed out (false) [last progress check: 2022-09-06 23:56:37 +0000 UTC - now: 2022-09-06 23:56:37.169968325 +0000 UTC m=+29.784280696]
I0906 23:56:37.169273       1 replica_set.go:457] Pod calico-kube-controllers-755ff8d7b5-78cgz updated, objectMeta {Name:calico-kube-controllers-755ff8d7b5-78cgz GenerateName:calico-kube-controllers-755ff8d7b5- Namespace:kube-system SelfLink: UID:dbd28a2e-50cc-45bc-a5c4-c11d9d811dda ResourceVersion:465 Generation:0 CreationTimestamp:2022-09-06 23:56:37 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[k8s-app:calico-kube-controllers pod-template-hash:755ff8d7b5] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:calico-kube-controllers-755ff8d7b5 UID:d9cbfbe9-99b1-4c1e-a19f-3091ac438041 Controller:0xc00239a80e BlockOwnerDeletion:0xc00239a80f}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:56:37 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"d9cbfbe9-99b1-4c1e-a19f-3091ac438041\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"calico-kube-controllers\"}":{".":{},"f:env":{".":{},"k:{\"name\":\"DATASTORE_TYPE\"}":{".":{},"f:name":{},"f:value":{}},"k:{\"name\":\"ENABLED_CONTROLLERS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:livenessProbe":{".":{},"f:exec":{".":{},"f:command":{}},"f:failureThreshold":{},"f:initialDelaySeconds":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:name":{},"f:readinessProbe":{".":{},"f:exec":{".":{},"f:command":{}},"f:failureThreshold":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:resources":{},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}} Subresource:}]} -> {Name:calico-kube-controllers-755ff8d7b5-78cgz GenerateName:calico-kube-controllers-755ff8d7b5- Namespace:kube-system SelfLink: UID:dbd28a2e-50cc-45bc-a5c4-c11d9d811dda ResourceVersion:468 Generation:0 CreationTimestamp:2022-09-06 23:56:37 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[k8s-app:calico-kube-controllers pod-template-hash:755ff8d7b5] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:calico-kube-controllers-755ff8d7b5 UID:d9cbfbe9-99b1-4c1e-a19f-3091ac438041 Controller:0xc002336a8e BlockOwnerDeletion:0xc002336a8f}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:56:37 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"d9cbfbe9-99b1-4c1e-a19f-3091ac438041\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"calico-kube-controllers\"}":{".":{},"f:env":{".":{},"k:{\"name\":\"DATASTORE_TYPE\"}":{".":{},"f:name":{},"f:value":{}},"k:{\"name\":\"ENABLED_CONTROLLERS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:livenessProbe":{".":{},"f:exec":{".":{},"f:command":{}},"f:failureThreshold":{},"f:initialDelaySeconds":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:name":{},"f:readinessProbe":{".":{},"f:exec":{".":{},"f:command":{}},"f:failureThreshold":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:resources":{},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}} Subresource:} {Manager:kube-scheduler Operation:Update APIVersion:v1 Time:2022-09-06 23:56:37 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{".":{},"k:{\"type\":\"PodScheduled\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}} Subresource:status}]}.
I0906 23:56:37.170817       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="kube-system/calico-kube-controllers-755ff8d7b5-78cgz" podUID=dbd28a2e-50cc-45bc-a5c4-c11d9d811dda
... skipping 320 lines ...
I0906 23:56:57.138890       1 replica_set.go:457] Pod coredns-84994b8c4-9w5x7 updated, objectMeta {Name:coredns-84994b8c4-9w5x7 GenerateName:coredns-84994b8c4- Namespace:kube-system SelfLink: UID:fd4a76d1-5b90-459d-8229-bba7bcb40275 ResourceVersion:532 Generation:0 CreationTimestamp:2022-09-06 23:56:22 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[k8s-app:kube-dns pod-template-hash:84994b8c4] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:coredns-84994b8c4 UID:988a05d4-eefc-42e2-82f5-f05587607397 Controller:0xc0020bad2f BlockOwnerDeletion:0xc0020bad50}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:56:22 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"988a05d4-eefc-42e2-82f5-f05587607397\"}":{}}},"f:spec":{"f:affinity":{".":{},"f:podAntiAffinity":{".":{},"f:preferredDuringSchedulingIgnoredDuringExecution":{}}},"f:containers":{"k:{\"name\":\"coredns\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:livenessProbe":{".":{},"f:failureThreshold":{},"f:httpGet":{".":{},"f:path":{},"f:port":{},"f:scheme":{}},"f:initialDelaySeconds":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:name":{},"f:ports":{".":{},"k:{\"containerPort\":53,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":53,\"protocol\":\"UDP\"}":{".":{},"f:containerPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":9153,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:name":{},"f:protocol":{}}},"f:readinessProbe":{".":{},"f:failureThreshold":{},"f:httpGet":{".":{},"f:path":{},"f:port":{},"f:scheme":{}},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:securityContext":{".":{},"f:allowPrivilegeEscalation":{},"f:capabilities":{".":{},"f:add":{},"f:drop":{}},"f:readOnlyRootFilesystem":{}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/etc/coredns\"}":{".":{},"f:mountPath":{},"f:name":{},"f:readOnly":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{},"f:volumes":{".":{},"k:{\"name\":\"config-volume\"}":{".":{},"f:configMap":{".":{},"f:defaultMode":{},"f:items":{},"f:name":{}},"f:name":{}}}}} Subresource:} {Manager:kube-scheduler Operation:Update APIVersion:v1 Time:2022-09-06 23:56:22 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{".":{},"k:{\"type\":\"PodScheduled\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}} Subresource:status}]} -> {Name:coredns-84994b8c4-9w5x7 GenerateName:coredns-84994b8c4- Namespace:kube-system SelfLink: UID:fd4a76d1-5b90-459d-8229-bba7bcb40275 ResourceVersion:541 Generation:0 CreationTimestamp:2022-09-06 23:56:22 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[k8s-app:kube-dns pod-template-hash:84994b8c4] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:coredns-84994b8c4 UID:988a05d4-eefc-42e2-82f5-f05587607397 Controller:0xc0020eda60 BlockOwnerDeletion:0xc0020eda61}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:56:22 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"988a05d4-eefc-42e2-82f5-f05587607397\"}":{}}},"f:spec":{"f:affinity":{".":{},"f:podAntiAffinity":{".":{},"f:preferredDuringSchedulingIgnoredDuringExecution":{}}},"f:containers":{"k:{\"name\":\"coredns\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:livenessProbe":{".":{},"f:failureThreshold":{},"f:httpGet":{".":{},"f:path":{},"f:port":{},"f:scheme":{}},"f:initialDelaySeconds":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:name":{},"f:ports":{".":{},"k:{\"containerPort\":53,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":53,\"protocol\":\"UDP\"}":{".":{},"f:containerPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":9153,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:name":{},"f:protocol":{}}},"f:readinessProbe":{".":{},"f:failureThreshold":{},"f:httpGet":{".":{},"f:path":{},"f:port":{},"f:scheme":{}},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:securityContext":{".":{},"f:allowPrivilegeEscalation":{},"f:capabilities":{".":{},"f:add":{},"f:drop":{}},"f:readOnlyRootFilesystem":{}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/etc/coredns\"}":{".":{},"f:mountPath":{},"f:name":{},"f:readOnly":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{},"f:volumes":{".":{},"k:{\"name\":\"config-volume\"}":{".":{},"f:configMap":{".":{},"f:defaultMode":{},"f:items":{},"f:name":{}},"f:name":{}}}}} Subresource:} {Manager:kube-scheduler Operation:Update APIVersion:v1 Time:2022-09-06 23:56:22 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{".":{},"k:{\"type\":\"PodScheduled\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}} Subresource:status} {Manager:kubelet Operation:Update APIVersion:v1 Time:2022-09-06 23:56:57 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{"k:{\"type\":\"ContainersReady\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}},"k:{\"type\":\"Initialized\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:status":{},"f:type":{}},"k:{\"type\":\"Ready\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}},"f:containerStatuses":{},"f:hostIP":{},"f:startTime":{}}} Subresource:status}]}.
I0906 23:56:57.139155       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/coredns-84994b8c4", timestamp:time.Time{wall:0xc0be1569aaadb99f, ext:15330340790, loc:(*time.Location)(0x6f10040)}}
I0906 23:56:57.139276       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/coredns-84994b8c4" (126.801µs)
I0906 23:56:59.476095       1 httplog.go:131] "HTTP" verb="GET" URI="/healthz" latency="104.1µs" userAgent="kube-probe/1.26+" audit-ID="" srcIP="127.0.0.1:55542" resp=200
I0906 23:57:00.811567       1 gc_controller.go:221] GC'ing orphaned
I0906 23:57:00.811601       1 gc_controller.go:290] GC'ing unscheduled pods which are terminating.
I0906 23:57:00.857437       1 node_lifecycle_controller.go:1084] ReadyCondition for Node capz-nlyx1d-control-plane-jp9jl transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-06 23:56:36 +0000 UTC,LastTransitionTime:2022-09-06 23:55:58 +0000 UTC,Reason:KubeletNotReady,Message:container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized,} to &NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-09-06 23:56:56 +0000 UTC,LastTransitionTime:2022-09-06 23:56:56 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0906 23:57:00.857596       1 node_lifecycle_controller.go:1092] Node capz-nlyx1d-control-plane-jp9jl ReadyCondition updated. Updating timestamp.
I0906 23:57:00.857627       1 node_lifecycle_controller.go:938] Node capz-nlyx1d-control-plane-jp9jl is healthy again, removing all taints
I0906 23:57:00.857667       1 node_lifecycle_controller.go:1236] Controller detected that some Nodes are Ready. Exiting master disruption mode.
I0906 23:57:01.875622       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-control-plane-jp9jl"
I0906 23:57:01.920169       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-control-plane-jp9jl"
I0906 23:57:02.018875       1 disruption.go:494] updatePod called on pod "calico-node-bndkr"
... skipping 236 lines ...
I0906 23:58:06.090766       1 certificate_controller.go:81] Updating certificate request csr-zkw5m
I0906 23:58:06.090781       1 certificate_controller.go:167] Finished syncing certificate request "csr-zkw5m" (1.4µs)
I0906 23:58:06.091531       1 certificate_controller.go:167] Finished syncing certificate request "csr-zkw5m" (14.265329ms)
I0906 23:58:06.091580       1 certificate_controller.go:167] Finished syncing certificate request "csr-zkw5m" (1.8µs)
I0906 23:58:09.474725       1 httplog.go:131] "HTTP" verb="GET" URI="/healthz" latency="95.401µs" userAgent="kube-probe/1.26+" audit-ID="" srcIP="127.0.0.1:49732" resp=200
I0906 23:58:15.954480       1 topologycache.go:179] Ignoring node capz-nlyx1d-control-plane-jp9jl because it has an excluded label
I0906 23:58:15.954637       1 topologycache.go:183] Ignoring node capz-nlyx1d-mp-0000000 because it is not ready: [{MemoryPressure False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletNotReady [container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized, failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "capz-nlyx1d-mp-0000000" not found]}]
I0906 23:58:15.954866       1 topologycache.go:215] Insufficient node info for topology hints (0 zones, %!s(int64=0) CPU, true)
I0906 23:58:15.955053       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-mp-0000000"
W0906 23:58:15.955198       1 actual_state_of_world.go:541] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="capz-nlyx1d-mp-0000000" does not exist
I0906 23:58:15.955411       1 controller.go:690] Syncing backends for all LB services.
I0906 23:58:15.955506       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0906 23:58:15.955608       1 controller.go:753] Finished updateLoadBalancerHosts
I0906 23:58:15.955738       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0906 23:58:15.955857       1 controller.go:686] It took 0.000446701 seconds to finish syncNodes
I0906 23:58:15.958375       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-node", timestamp:time.Time{wall:0xc0be1574ef5da157, ext:60408977674, loc:(*time.Location)(0x6f10040)}}
... skipping 86 lines ...
I0906 23:58:16.118201       1 daemon_controller.go:1036] Pods to delete for daemon set calico-node: [], deleting 0
I0906 23:58:16.118233       1 daemon_controller.go:1119] Updating daemon set status
I0906 23:58:16.118364       1 daemon_controller.go:1179] Finished syncing daemon set "kube-system/calico-node" (2.207208ms)
I0906 23:58:18.886209       1 taint_manager.go:466] "Noticed node update" node={nodeName:capz-nlyx1d-mp-0000001}
I0906 23:58:18.886269       1 taint_manager.go:471] "Updating known taints on node" node="capz-nlyx1d-mp-0000001" taints=[]
I0906 23:58:18.887227       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-mp-0000001"
W0906 23:58:18.887332       1 actual_state_of_world.go:541] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="capz-nlyx1d-mp-0000001" does not exist
I0906 23:58:18.887501       1 topologycache.go:179] Ignoring node capz-nlyx1d-control-plane-jp9jl because it has an excluded label
I0906 23:58:18.887542       1 topologycache.go:183] Ignoring node capz-nlyx1d-mp-0000000 because it is not ready: [{MemoryPressure False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-06 23:58:15 +0000 UTC 2022-09-06 23:58:15 +0000 UTC KubeletNotReady [container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized, failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "capz-nlyx1d-mp-0000000" not found]}]
I0906 23:58:18.887681       1 topologycache.go:183] Ignoring node capz-nlyx1d-mp-0000001 because it is not ready: [{MemoryPressure False 2022-09-06 23:58:18 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-06 23:58:18 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-06 23:58:18 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-06 23:58:18 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletNotReady [container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized, failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "capz-nlyx1d-mp-0000001" not found]}]
I0906 23:58:18.887865       1 topologycache.go:215] Insufficient node info for topology hints (0 zones, %!s(int64=0) CPU, true)
I0906 23:58:18.887964       1 controller.go:690] Syncing backends for all LB services.
I0906 23:58:18.887994       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0906 23:58:18.888118       1 controller.go:753] Finished updateLoadBalancerHosts
I0906 23:58:18.888136       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0906 23:58:18.889421       1 controller.go:686] It took 0.00147411 seconds to finish syncNodes
... skipping 379 lines ...
I0906 23:58:44.715920       1 azure_instances.go:251] InstanceShutdownByProviderID gets provisioning state "Creating" for node "capz-nlyx1d-mp-0000000"
I0906 23:58:44.716136       1 azure_instances.go:240] InstanceShutdownByProviderID gets power status "running" for node "capz-nlyx1d-mp-0000001"
I0906 23:58:44.716165       1 azure_instances.go:251] InstanceShutdownByProviderID gets provisioning state "Creating" for node "capz-nlyx1d-mp-0000001"
I0906 23:58:46.362109       1 controller_utils.go:205] "Added taint to node" taint=[] node="capz-nlyx1d-mp-0000000"
I0906 23:58:46.363023       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-mp-0000000"
I0906 23:58:46.363114       1 topologycache.go:179] Ignoring node capz-nlyx1d-control-plane-jp9jl because it has an excluded label
I0906 23:58:46.365919       1 topologycache.go:183] Ignoring node capz-nlyx1d-mp-0000001 because it is not ready: [{MemoryPressure False 2022-09-06 23:58:39 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-06 23:58:39 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-06 23:58:39 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-06 23:58:39 +0000 UTC 2022-09-06 23:58:18 +0000 UTC KubeletNotReady container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized}]
I0906 23:58:46.363156       1 controller.go:690] Syncing backends for all LB services.
I0906 23:58:46.366073       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0906 23:58:46.366189       1 controller.go:753] Finished updateLoadBalancerHosts
I0906 23:58:46.366251       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0906 23:58:46.366317       1 controller.go:686] It took 0.003160307 seconds to finish syncNodes
I0906 23:58:46.366157       1 topologycache.go:215] Insufficient node info for topology hints (1 zones, %!s(int64=2000) CPU, true)
... skipping 27 lines ...
I0906 23:58:49.414947       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-mp-0000001"
I0906 23:58:49.416748       1 controller_utils.go:217] "Made sure that node has no taint" node="capz-nlyx1d-mp-0000001" taint=[&Taint{Key:node.kubernetes.io/not-ready,Value:,Effect:NoSchedule,TimeAdded:<nil>,}]
I0906 23:58:49.474741       1 httplog.go:131] "HTTP" verb="GET" URI="/healthz" latency="100.4µs" userAgent="kube-probe/1.26+" audit-ID="" srcIP="127.0.0.1:51574" resp=200
I0906 23:58:50.718325       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0906 23:58:50.732221       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0906 23:58:50.780854       1 pv_controller_base.go:612] resyncing PV controller
I0906 23:58:50.876789       1 node_lifecycle_controller.go:1084] ReadyCondition for Node capz-nlyx1d-mp-0000000 transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-06 23:58:36 +0000 UTC,LastTransitionTime:2022-09-06 23:58:15 +0000 UTC,Reason:KubeletNotReady,Message:container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized,} to &NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-09-06 23:58:46 +0000 UTC,LastTransitionTime:2022-09-06 23:58:46 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0906 23:58:50.876958       1 node_lifecycle_controller.go:1092] Node capz-nlyx1d-mp-0000000 ReadyCondition updated. Updating timestamp.
I0906 23:58:50.887293       1 node_lifecycle_controller.go:938] Node capz-nlyx1d-mp-0000000 is healthy again, removing all taints
I0906 23:58:50.887370       1 node_lifecycle_controller.go:1084] ReadyCondition for Node capz-nlyx1d-mp-0000001 transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-06 23:58:39 +0000 UTC,LastTransitionTime:2022-09-06 23:58:18 +0000 UTC,Reason:KubeletNotReady,Message:container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized,} to &NodeCondition{Type:Ready,Status:True,LastHeartbeatTime:2022-09-06 23:58:49 +0000 UTC,LastTransitionTime:2022-09-06 23:58:49 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0906 23:58:50.887450       1 node_lifecycle_controller.go:1092] Node capz-nlyx1d-mp-0000001 ReadyCondition updated. Updating timestamp.
I0906 23:58:50.890626       1 taint_manager.go:466] "Noticed node update" node={nodeName:capz-nlyx1d-mp-0000000}
I0906 23:58:50.890715       1 taint_manager.go:471] "Updating known taints on node" node="capz-nlyx1d-mp-0000000" taints=[]
I0906 23:58:50.890815       1 taint_manager.go:492] "All taints were removed from the node. Cancelling all evictions..." node="capz-nlyx1d-mp-0000000"
I0906 23:58:50.890899       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-nlyx1d-mp-0000000"
I0906 23:58:50.907347       1 taint_manager.go:466] "Noticed node update" node={nodeName:capz-nlyx1d-mp-0000001}
... skipping 186 lines ...
I0906 23:58:53.937339       1 controller_utils.go:581] Controller csi-azuredisk-controller-6dbf65647f created pod csi-azuredisk-controller-6dbf65647f-5tg85
I0906 23:58:53.938288       1 event.go:294] "Event occurred" object="kube-system/csi-azuredisk-controller-6dbf65647f" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.938607       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.938637       1 disruption.go:479] addPod called on pod "csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.938689       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-azuredisk-controller-6dbf65647f-5tg85, PodDisruptionBudget controller will avoid syncing.
I0906 23:58:53.938697       1 disruption.go:482] No matching pdb for pod "csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.938724       1 replica_set.go:394] Pod csi-azuredisk-controller-6dbf65647f-5tg85 created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"csi-azuredisk-controller-6dbf65647f-5tg85", GenerateName:"csi-azuredisk-controller-6dbf65647f-", Namespace:"kube-system", SelfLink:"", UID:"41230978-7a21-4dc5-a4f7-d6e06b735b8b", ResourceVersion:"918", Generation:0, CreationTimestamp:time.Date(2022, time.September, 6, 23, 58, 53, 0, time.Local), DeletionTimestamp:<nil>, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"app":"csi-azuredisk-controller", "pod-template-hash":"6dbf65647f"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"csi-azuredisk-controller-6dbf65647f", UID:"7fd82d63-c14b-4a63-ad0f-22711483b563", Controller:(*bool)(0xc00223e6f7), BlockOwnerDeletion:(*bool)(0xc00223e6f8)}}, Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:time.Date(2022, time.September, 6, 23, 58, 53, 0, time.Local), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc000cddfb0), Subresource:""}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"socket-dir", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(0xc000cddfe0), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(nil), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}, v1.Volume{Name:"azure-cred", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(0xc001020030), EmptyDir:(*v1.EmptyDirVolumeSource)(nil), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(nil), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}, v1.Volume{Name:"kube-api-access-td4cm", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(nil), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(0xc001cd3960), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}}, InitContainers:[]v1.Container(nil), Containers:[]v1.Container{v1.Container{Name:"csi-provisioner", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner:v3.2.0", Command:[]string(nil), Args:[]string{"--feature-gates=Topology=true", "--csi-address=$(ADDRESS)", "--v=2", "--timeout=15s", "--leader-election", "--leader-election-namespace=kube-system", "--worker-threads=40", "--extra-create-metadata=true", "--strict-topology=true"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-td4cm", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"csi-attacher", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-attacher:v3.5.0", Command:[]string(nil), Args:[]string{"-v=2", "-csi-address=$(ADDRESS)", "-timeout=600s", "-leader-election", "--leader-election-namespace=kube-system", "-worker-threads=500"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-td4cm", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"csi-snapshotter", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter:v5.0.1", Command:[]string(nil), Args:[]string{"-csi-address=$(ADDRESS)", "-leader-election", "--leader-election-namespace=kube-system", "--v=2"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:104857600, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-td4cm", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"csi-resizer", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.5.0", Command:[]string(nil), Args:[]string{"-csi-address=$(ADDRESS)", "-v=2", "-leader-election", "--leader-election-namespace=kube-system", "-handle-volume-inuse-error=false", "-feature-gates=RecoverVolumeExpansionFailure=true", "-timeout=240s"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-td4cm", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"liveness-probe", Image:"mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.7.0", Command:[]string(nil), Args:[]string{"--csi-address=/csi/csi.sock", "--probe-timeout=3s", "--health-port=29602", "--v=2"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:104857600, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-td4cm", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"azuredisk", Image:"mcr.microsoft.com/k8s/csi/azuredisk-csi:latest", Command:[]string(nil), Args:[]string{"--v=5", "--endpoint=$(CSI_ENDPOINT)", "--metrics-address=0.0.0.0:29604", "--user-agent-suffix=OSS-kubectl", "--disable-avset-nodes=false", "--allow-empty-cloud-config=false"}, WorkingDir:"", Ports:[]v1.ContainerPort{v1.ContainerPort{Name:"healthz", HostPort:29602, ContainerPort:29602, Protocol:"TCP", HostIP:""}, v1.ContainerPort{Name:"metrics", HostPort:29604, ContainerPort:29604, Protocol:"TCP", HostIP:""}}, EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"AZURE_CREDENTIAL_FILE", Value:"", ValueFrom:(*v1.EnvVarSource)(0xc001cd3a80)}, v1.EnvVar{Name:"CSI_ENDPOINT", Value:"unix:///csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"azure-cred", ReadOnly:false, MountPath:"/etc/kubernetes/", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-td4cm", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(0xc001fd5a80), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, EphemeralContainers:[]v1.EphemeralContainer(nil), RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc00223ead0), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string{"kubernetes.io/os":"linux"}, ServiceAccountName:"csi-azuredisk-controller-sa", DeprecatedServiceAccount:"csi-azuredisk-controller-sa", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:true, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc0005d2bd0), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node-role.kubernetes.io/master", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/controlplane", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/control-plane", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc00223eb40)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc00223eb60)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc00223eb68), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc00223eb6c), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc00294bc40), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil), SetHostnameAsFQDN:(*bool)(nil), OS:(*v1.PodOS)(nil), HostUsers:(*bool)(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition(nil), Message:"", Reason:"", NominatedNodeName:"", HostIP:"", PodIP:"", PodIPs:[]v1.PodIP(nil), StartTime:<nil>, InitContainerStatuses:[]v1.ContainerStatus(nil), ContainerStatuses:[]v1.ContainerStatus(nil), QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}.
I0906 23:58:53.942487       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/csi-azuredisk-controller-6dbf65647f", timestamp:time.Time{wall:0xc0be158f772ec56f, ext:166540124450, loc:(*time.Location)(0x6f10040)}}
I0906 23:58:53.942567       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="kube-system/csi-azuredisk-controller-6dbf65647f-5tg85" podUID=41230978-7a21-4dc5-a4f7-d6e06b735b8b
I0906 23:58:53.946828       1 deployment_util.go:775] Deployment "csi-azuredisk-controller" timed out (false) [last progress check: 2022-09-06 23:58:53.926864682 +0000 UTC m=+166.541177153 - now: 2022-09-06 23:58:53.946820446 +0000 UTC m=+166.561132917]
I0906 23:58:53.947255       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/csi-azuredisk-controller"
I0906 23:58:53.956126       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azuredisk-controller-6dbf65647f-4l8vn"
I0906 23:58:53.957181       1 disruption.go:479] addPod called on pod "csi-azuredisk-controller-6dbf65647f-4l8vn"
I0906 23:58:53.961847       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-azuredisk-controller-6dbf65647f-4l8vn, PodDisruptionBudget controller will avoid syncing.
I0906 23:58:53.957230       1 replica_set.go:394] Pod csi-azuredisk-controller-6dbf65647f-4l8vn created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"csi-azuredisk-controller-6dbf65647f-4l8vn", GenerateName:"csi-azuredisk-controller-6dbf65647f-", Namespace:"kube-system", SelfLink:"", UID:"a8566559-d02e-40af-9b8b-ccf4da512aa8", ResourceVersion:"922", Generation:0, CreationTimestamp:time.Date(2022, time.September, 6, 23, 58, 53, 0, time.Local), DeletionTimestamp:<nil>, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"app":"csi-azuredisk-controller", "pod-template-hash":"6dbf65647f"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"csi-azuredisk-controller-6dbf65647f", UID:"7fd82d63-c14b-4a63-ad0f-22711483b563", Controller:(*bool)(0xc002306c97), BlockOwnerDeletion:(*bool)(0xc002306c98)}}, Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:time.Date(2022, time.September, 6, 23, 58, 53, 0, time.Local), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc001020c48), Subresource:""}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"socket-dir", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(0xc001020c60), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(nil), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}, v1.Volume{Name:"azure-cred", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(0xc001020c78), EmptyDir:(*v1.EmptyDirVolumeSource)(nil), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(nil), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}, v1.Volume{Name:"kube-api-access-4d8jc", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(nil), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(0xc0001a86a0), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}}, InitContainers:[]v1.Container(nil), Containers:[]v1.Container{v1.Container{Name:"csi-provisioner", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-provisioner:v3.2.0", Command:[]string(nil), Args:[]string{"--feature-gates=Topology=true", "--csi-address=$(ADDRESS)", "--v=2", "--timeout=15s", "--leader-election", "--leader-election-namespace=kube-system", "--worker-threads=40", "--extra-create-metadata=true", "--strict-topology=true"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-4d8jc", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"csi-attacher", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-attacher:v3.5.0", Command:[]string(nil), Args:[]string{"-v=2", "-csi-address=$(ADDRESS)", "-timeout=600s", "-leader-election", "--leader-election-namespace=kube-system", "-worker-threads=500"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-4d8jc", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"csi-snapshotter", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-snapshotter:v5.0.1", Command:[]string(nil), Args:[]string{"-csi-address=$(ADDRESS)", "-leader-election", "--leader-election-namespace=kube-system", "--v=2"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:104857600, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-4d8jc", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"csi-resizer", Image:"mcr.microsoft.com/oss/kubernetes-csi/csi-resizer:v1.5.0", Command:[]string(nil), Args:[]string{"-csi-address=$(ADDRESS)", "-v=2", "-leader-election", "--leader-election-namespace=kube-system", "-handle-volume-inuse-error=false", "-feature-gates=RecoverVolumeExpansionFailure=true", "-timeout=240s"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ADDRESS", Value:"/csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-4d8jc", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"liveness-probe", Image:"mcr.microsoft.com/oss/kubernetes-csi/livenessprobe:v2.7.0", Command:[]string(nil), Args:[]string{"--csi-address=/csi/csi.sock", "--probe-timeout=3s", "--health-port=29602", "--v=2"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:104857600, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-4d8jc", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"azuredisk", Image:"mcr.microsoft.com/k8s/csi/azuredisk-csi:latest", Command:[]string(nil), Args:[]string{"--v=5", "--endpoint=$(CSI_ENDPOINT)", "--metrics-address=0.0.0.0:29604", "--user-agent-suffix=OSS-kubectl", "--disable-avset-nodes=false", "--allow-empty-cloud-config=false"}, WorkingDir:"", Ports:[]v1.ContainerPort{v1.ContainerPort{Name:"healthz", HostPort:29602, ContainerPort:29602, Protocol:"TCP", HostIP:""}, v1.ContainerPort{Name:"metrics", HostPort:29604, ContainerPort:29604, Protocol:"TCP", HostIP:""}}, EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"AZURE_CREDENTIAL_FILE", Value:"", ValueFrom:(*v1.EnvVarSource)(0xc0001a8940)}, v1.EnvVar{Name:"CSI_ENDPOINT", Value:"unix:///csi/csi.sock", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:524288000, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"500Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"socket-dir", ReadOnly:false, MountPath:"/csi", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"azure-cred", ReadOnly:false, MountPath:"/etc/kubernetes/", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}, v1.VolumeMount{Name:"kube-api-access-4d8jc", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(0xc00218f000), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, EphemeralContainers:[]v1.EphemeralContainer(nil), RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc002307070), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string{"kubernetes.io/os":"linux"}, ServiceAccountName:"csi-azuredisk-controller-sa", DeprecatedServiceAccount:"csi-azuredisk-controller-sa", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:true, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc0005d3180), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node-role.kubernetes.io/master", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/controlplane", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/control-plane", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0023070e0)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc002307100)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc002307108), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc00230710c), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc002adcef0), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil), SetHostnameAsFQDN:(*bool)(nil), OS:(*v1.PodOS)(nil), HostUsers:(*bool)(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition(nil), Message:"", Reason:"", NominatedNodeName:"", HostIP:"", PodIP:"", PodIPs:[]v1.PodIP(nil), StartTime:<nil>, InitContainerStatuses:[]v1.ContainerStatus(nil), ContainerStatuses:[]v1.ContainerStatus(nil), QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}.
I0906 23:58:53.957790       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="kube-system/csi-azuredisk-controller-6dbf65647f-4l8vn" podUID=a8566559-d02e-40af-9b8b-ccf4da512aa8
I0906 23:58:53.961479       1 controller_utils.go:581] Controller csi-azuredisk-controller-6dbf65647f created pod csi-azuredisk-controller-6dbf65647f-4l8vn
I0906 23:58:53.962373       1 disruption.go:482] No matching pdb for pod "csi-azuredisk-controller-6dbf65647f-4l8vn"
I0906 23:58:53.962626       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/csi-azuredisk-controller-6dbf65647f", timestamp:time.Time{wall:0xc0be158f772ec56f, ext:166540124450, loc:(*time.Location)(0x6f10040)}}
I0906 23:58:53.962767       1 replica_set_utils.go:59] Updating status for : kube-system/csi-azuredisk-controller-6dbf65647f, replicas 0->0 (need 2), fullyLabeledReplicas 0->0, readyReplicas 0->0, availableReplicas 0->0, sequence No: 0->1
I0906 23:58:53.963240       1 event.go:294] "Event occurred" object="kube-system/csi-azuredisk-controller-6dbf65647f" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: csi-azuredisk-controller-6dbf65647f-4l8vn"
I0906 23:58:53.977550       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-azuredisk-controller" duration="69.892022ms"
I0906 23:58:53.978652       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/csi-azuredisk-controller" err="Operation cannot be fulfilled on deployments.apps \"csi-azuredisk-controller\": the object has been modified; please apply your changes to the latest version and try again"
I0906 23:58:53.978626       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.978968       1 disruption.go:494] updatePod called on pod "csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.980075       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-azuredisk-controller-6dbf65647f-5tg85, PodDisruptionBudget controller will avoid syncing.
I0906 23:58:53.980090       1 disruption.go:497] No matching pdb for pod "csi-azuredisk-controller-6dbf65647f-5tg85"
I0906 23:58:53.978999       1 replica_set.go:457] Pod csi-azuredisk-controller-6dbf65647f-5tg85 updated, objectMeta {Name:csi-azuredisk-controller-6dbf65647f-5tg85 GenerateName:csi-azuredisk-controller-6dbf65647f- Namespace:kube-system SelfLink: UID:41230978-7a21-4dc5-a4f7-d6e06b735b8b ResourceVersion:918 Generation:0 CreationTimestamp:2022-09-06 23:58:53 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-azuredisk-controller pod-template-hash:6dbf65647f] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-azuredisk-controller-6dbf65647f UID:7fd82d63-c14b-4a63-ad0f-22711483b563 Controller:0xc00223e6f7 BlockOwnerDeletion:0xc00223e6f8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:58:53 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"7fd82d63-c14b-4a63-ad0f-22711483b563\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"azuredisk\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"AZURE_CREDENTIAL_FILE\"}":{".":{},"f:name":{},"f:valueFrom":{".":{},"f:configMapKeyRef":{}}},"k:{\"name\":\"CSI_ENDPOINT\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:livenessProbe":{".":{},"f:failureThreshold":{},"f:httpGet":{".":{},"f:path":{},"f:port":{},"f:scheme":{}},"f:initialDelaySeconds":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:name":{},"f:ports":{".":{},"k:{\"containerPort\":29602,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":29604,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}}},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}},"k:{\"mountPath\":\"/etc/kubernetes/\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-attacher\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-provisioner\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-resizer\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-snapshotter\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"liveness-probe\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:hostNetwork":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{},"f:volumes":{".":{},"k:{\"name\":\"azure-cred\"}":{".":{},"f:hostPath":{".":{},"f:path":{},"f:type":{}},"f:name":{}},"k:{\"name\":\"socket-dir\"}":{".":{},"f:emptyDir":{},"f:name":{}}}}} Subresource:}]} -> {Name:csi-azuredisk-controller-6dbf65647f-5tg85 GenerateName:csi-azuredisk-controller-6dbf65647f- Namespace:kube-system SelfLink: UID:41230978-7a21-4dc5-a4f7-d6e06b735b8b ResourceVersion:923 Generation:0 CreationTimestamp:2022-09-06 23:58:53 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-azuredisk-controller pod-template-hash:6dbf65647f] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-azuredisk-controller-6dbf65647f UID:7fd82d63-c14b-4a63-ad0f-22711483b563 Controller:0xc002201827 BlockOwnerDeletion:0xc002201828}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:58:53 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"7fd82d63-c14b-4a63-ad0f-22711483b563\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"azuredisk\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"AZURE_CREDENTIAL_FILE\"}":{".":{},"f:name":{},"f:valueFrom":{".":{},"f:configMapKeyRef":{}}},"k:{\"name\":\"CSI_ENDPOINT\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:livenessProbe":{".":{},"f:failureThreshold":{},"f:httpGet":{".":{},"f:path":{},"f:port":{},"f:scheme":{}},"f:initialDelaySeconds":{},"f:periodSeconds":{},"f:successThreshold":{},"f:timeoutSeconds":{}},"f:name":{},"f:ports":{".":{},"k:{\"containerPort\":29602,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":29604,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}}},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}},"k:{\"mountPath\":\"/etc/kubernetes/\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-attacher\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-provisioner\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-resizer\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"csi-snapshotter\"}":{".":{},"f:args":{},"f:env":{".":{},"k:{\"name\":\"ADDRESS\"}":{".":{},"f:name":{},"f:value":{}}},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}},"k:{\"name\":\"liveness-probe\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/csi\"}":{".":{},"f:mountPath":{},"f:name":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:hostNetwork":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{},"f:volumes":{".":{},"k:{\"name\":\"azure-cred\"}":{".":{},"f:hostPath":{".":{},"f:path":{},"f:type":{}},"f:name":{}},"k:{\"name\":\"socket-dir\"}":{".":{},"f:emptyDir":{},"f:name":{}}}}} Subresource:}]}.
I0906 23:58:53.984319       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-azuredisk-controller" startTime="2022-09-06 23:58:53.979802851 +0000 UTC m=+166.594115222"
... skipping 87 lines ...
I0906 23:58:56.038922       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-snapshot-controller-84ccd6c756-q9gtj, PodDisruptionBudget controller will avoid syncing.
I0906 23:58:56.038946       1 disruption.go:482] No matching pdb for pod "csi-snapshot-controller-84ccd6c756-q9gtj"
I0906 23:58:56.038975       1 replica_set.go:394] Pod csi-snapshot-controller-84ccd6c756-q9gtj created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"csi-snapshot-controller-84ccd6c756-q9gtj", GenerateName:"csi-snapshot-controller-84ccd6c756-", Namespace:"kube-system", SelfLink:"", UID:"0b02dfbc-74a0-4e26-a992-74d45dfeccd7", ResourceVersion:"979", Generation:0, CreationTimestamp:time.Date(2022, time.September, 6, 23, 58, 55, 0, time.Local), DeletionTimestamp:<nil>, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"app":"csi-snapshot-controller", "pod-template-hash":"84ccd6c756"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"csi-snapshot-controller-84ccd6c756", UID:"d9aae831-8ae1-4a08-93e9-7bf584fa1d54", Controller:(*bool)(0xc002424837), BlockOwnerDeletion:(*bool)(0xc002424838)}}, Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:time.Date(2022, time.September, 6, 23, 58, 55, 0, time.Local), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc0017d5c50), Subresource:""}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"kube-api-access-9444k", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(nil), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(nil), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(0xc0002119c0), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil), CSI:(*v1.CSIVolumeSource)(nil), Ephemeral:(*v1.EphemeralVolumeSource)(nil)}}}, InitContainers:[]v1.Container(nil), Containers:[]v1.Container{v1.Container{Name:"csi-snapshot-controller", Image:"mcr.microsoft.com/oss/kubernetes-csi/snapshot-controller:v5.0.1", Command:[]string(nil), Args:[]string{"--v=2", "--leader-election=true", "--leader-election-namespace=kube-system"}, WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"memory":resource.Quantity{i:resource.int64Amount{value:104857600, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100Mi", Format:"BinarySI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:10, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"10m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:20971520, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"20Mi", Format:"BinarySI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"kube-api-access-9444k", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, EphemeralContainers:[]v1.EphemeralContainer(nil), RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc0024248d8), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string{"kubernetes.io/os":"linux"}, ServiceAccountName:"csi-snapshot-controller-sa", DeprecatedServiceAccount:"csi-snapshot-controller-sa", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc0006fbea0), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node-role.kubernetes.io/master", Operator:"Equal", Value:"true", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/controlplane", Operator:"Equal", Value:"true", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/control-plane", Operator:"Equal", Value:"true", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc002424960)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc002424980)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc002424988), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc00242498c), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc002af2690), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil), SetHostnameAsFQDN:(*bool)(nil), OS:(*v1.PodOS)(nil), HostUsers:(*bool)(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition(nil), Message:"", Reason:"", NominatedNodeName:"", HostIP:"", PodIP:"", PodIPs:[]v1.PodIP(nil), StartTime:<nil>, InitContainerStatuses:[]v1.ContainerStatus(nil), ContainerStatuses:[]v1.ContainerStatus(nil), QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}.
I0906 23:58:56.039327       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/csi-snapshot-controller-84ccd6c756", timestamp:time.Time{wall:0xc0be158ff1f1d9f0, ext:168452246023, loc:(*time.Location)(0x6f10040)}}
I0906 23:58:56.039402       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="kube-system/csi-snapshot-controller-84ccd6c756-q9gtj" podUID=0b02dfbc-74a0-4e26-a992-74d45dfeccd7
I0906 23:58:56.039710       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="216.623888ms"
I0906 23:58:56.039829       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/csi-snapshot-controller" err="Operation cannot be fulfilled on deployments.apps \"csi-snapshot-controller\": the object has been modified; please apply your changes to the latest version and try again"
I0906 23:58:56.039978       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-snapshot-controller" startTime="2022-09-06 23:58:56.039958894 +0000 UTC m=+168.654271265"
I0906 23:58:56.040617       1 deployment_util.go:775] Deployment "csi-snapshot-controller" timed out (false) [last progress check: 2022-09-06 23:58:55 +0000 UTC - now: 2022-09-06 23:58:56.040609896 +0000 UTC m=+168.654922367]
I0906 23:58:56.045512       1 controller_utils.go:581] Controller csi-snapshot-controller-84ccd6c756 created pod csi-snapshot-controller-84ccd6c756-q9gtj
I0906 23:58:56.045585       1 replica_set_utils.go:59] Updating status for : kube-system/csi-snapshot-controller-84ccd6c756, replicas 0->0 (need 2), fullyLabeledReplicas 0->0, readyReplicas 0->0, availableReplicas 0->0, sequence No: 0->1
I0906 23:58:56.046095       1 event.go:294] "Event occurred" object="kube-system/csi-snapshot-controller-84ccd6c756" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: csi-snapshot-controller-84ccd6c756-q9gtj"
I0906 23:58:56.070494       1 replica_set.go:457] Pod csi-snapshot-controller-84ccd6c756-q9gtj updated, objectMeta {Name:csi-snapshot-controller-84ccd6c756-q9gtj GenerateName:csi-snapshot-controller-84ccd6c756- Namespace:kube-system SelfLink: UID:0b02dfbc-74a0-4e26-a992-74d45dfeccd7 ResourceVersion:979 Generation:0 CreationTimestamp:2022-09-06 23:58:55 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-snapshot-controller pod-template-hash:84ccd6c756] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-snapshot-controller-84ccd6c756 UID:d9aae831-8ae1-4a08-93e9-7bf584fa1d54 Controller:0xc002424837 BlockOwnerDeletion:0xc002424838}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:58:55 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"d9aae831-8ae1-4a08-93e9-7bf584fa1d54\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"csi-snapshot-controller\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}} Subresource:}]} -> {Name:csi-snapshot-controller-84ccd6c756-q9gtj GenerateName:csi-snapshot-controller-84ccd6c756- Namespace:kube-system SelfLink: UID:0b02dfbc-74a0-4e26-a992-74d45dfeccd7 ResourceVersion:981 Generation:0 CreationTimestamp:2022-09-06 23:58:55 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-snapshot-controller pod-template-hash:84ccd6c756] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-snapshot-controller-84ccd6c756 UID:d9aae831-8ae1-4a08-93e9-7bf584fa1d54 Controller:0xc00256ece7 BlockOwnerDeletion:0xc00256ece8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:58:55 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"d9aae831-8ae1-4a08-93e9-7bf584fa1d54\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"csi-snapshot-controller\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}} Subresource:}]}.
... skipping 11 lines ...
I0906 23:58:56.090365       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/csi-snapshot-controller"
I0906 23:58:56.090578       1 disruption.go:494] updatePod called on pod "csi-snapshot-controller-84ccd6c756-wpqh4"
I0906 23:58:56.090612       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-snapshot-controller-84ccd6c756-wpqh4, PodDisruptionBudget controller will avoid syncing.
I0906 23:58:56.090636       1 disruption.go:497] No matching pdb for pod "csi-snapshot-controller-84ccd6c756-wpqh4"
I0906 23:58:56.090662       1 replica_set.go:457] Pod csi-snapshot-controller-84ccd6c756-wpqh4 updated, objectMeta {Name:csi-snapshot-controller-84ccd6c756-wpqh4 GenerateName:csi-snapshot-controller-84ccd6c756- Namespace:kube-system SelfLink: UID:3765fa84-316c-430d-b28a-1407c0b11ada ResourceVersion:977 Generation:0 CreationTimestamp:2022-09-06 23:58:55 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-snapshot-controller pod-template-hash:84ccd6c756] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-snapshot-controller-84ccd6c756 UID:d9aae831-8ae1-4a08-93e9-7bf584fa1d54 Controller:0xc00256e9d7 BlockOwnerDeletion:0xc00256e9d8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:58:55 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"d9aae831-8ae1-4a08-93e9-7bf584fa1d54\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"csi-snapshot-controller\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}} Subresource:}]} -> {Name:csi-snapshot-controller-84ccd6c756-wpqh4 GenerateName:csi-snapshot-controller-84ccd6c756- Namespace:kube-system SelfLink: UID:3765fa84-316c-430d-b28a-1407c0b11ada ResourceVersion:984 Generation:0 CreationTimestamp:2022-09-06 23:58:55 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-snapshot-controller pod-template-hash:84ccd6c756] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-snapshot-controller-84ccd6c756 UID:d9aae831-8ae1-4a08-93e9-7bf584fa1d54 Controller:0xc002425937 BlockOwnerDeletion:0xc002425938}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-06 23:58:55 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"d9aae831-8ae1-4a08-93e9-7bf584fa1d54\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"csi-snapshot-controller\"}":{".":{},"f:args":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{".":{},"f:limits":{".":{},"f:memory":{}},"f:requests":{".":{},"f:cpu":{},"f:memory":{}}},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}} Subresource:} {Manager:kubelet Operation:Update APIVersion:v1 Time:2022-09-06 23:58:56 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{"k:{\"type\":\"ContainersReady\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}},"k:{\"type\":\"Initialized\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:status":{},"f:type":{}},"k:{\"type\":\"Ready\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}},"f:containerStatuses":{},"f:hostIP":{},"f:startTime":{}}} Subresource:status}]}.
I0906 23:58:56.116499       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="36.976917ms"
I0906 23:58:56.116534       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/csi-snapshot-controller" err="Operation cannot be fulfilled on deployments.apps \"csi-snapshot-controller\": the object has been modified; please apply your changes to the latest version and try again"
I0906 23:58:56.116566       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-snapshot-controller" startTime="2022-09-06 23:58:56.116551837 +0000 UTC m=+168.730864208"
I0906 23:58:56.116962       1 deployment_util.go:775] Deployment "csi-snapshot-controller" timed out (false) [last progress check: 2022-09-06 23:58:55 +0000 UTC - now: 2022-09-06 23:58:56.116955138 +0000 UTC m=+168.731267609]
I0906 23:58:56.117004       1 progress.go:195] Queueing up deployment "csi-snapshot-controller" for a progress check after 598s
I0906 23:58:56.117020       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="460.401µs"
I0906 23:58:56.126876       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="kube-system/csi-snapshot-controller-84ccd6c756"
I0906 23:58:56.126913       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-snapshot-controller" startTime="2022-09-06 23:58:56.126898569 +0000 UTC m=+168.741210940"
... skipping 544 lines ...
I0907 00:01:31.429217       1 pv_protection_controller.go:121] Processing PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1
I0907 00:01:31.435634       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1" with version 1520
I0907 00:01:31.435892       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1]: phase: Released, bound to: "azuredisk-8081/pvc-fqmnx (uid: 4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1)", boundByController: false
I0907 00:01:31.435806       1 pv_protection_controller.go:198] Got event on PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1
I0907 00:01:31.436109       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1]: volume is bound to claim azuredisk-8081/pvc-fqmnx
I0907 00:01:31.436126       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1]: claim azuredisk-8081/pvc-fqmnx not found
I0907 00:01:31.452481       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1: Operation cannot be fulfilled on persistentvolumes "pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1": the object has been modified; please apply your changes to the latest version and try again
I0907 00:01:31.452544       1 pv_protection_controller.go:124] Finished processing PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1 (23.179292ms)
E0907 00:01:31.452595       1 pv_protection_controller.go:114] PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1 failed with : Operation cannot be fulfilled on persistentvolumes "pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1": the object has been modified; please apply your changes to the latest version and try again
I0907 00:01:31.452691       1 pv_protection_controller.go:121] Processing PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1
I0907 00:01:31.457763       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1
I0907 00:01:31.457787       1 pv_protection_controller.go:124] Finished processing PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1 (5.01092ms)
I0907 00:01:31.457872       1 pv_controller_base.go:238] volume "pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1" deleted
I0907 00:01:31.458181       1 pv_controller_base.go:589] deletion of claim "azuredisk-8081/pvc-fqmnx" was already processed
I0907 00:01:31.457799       1 pv_protection_controller.go:121] Processing PV pvc-4c4d1e96-4554-4d76-bc46-eabb2f6bb4c1
... skipping 537 lines ...
I0907 00:04:15.564972       1 pv_protection_controller.go:121] Processing PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6
I0907 00:04:15.571981       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6" with version 2002
I0907 00:04:15.572015       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6]: phase: Released, bound to: "azuredisk-5466/pvc-8tt77 (uid: 129f01c6-05e5-4a1d-883a-0197fd7055e6)", boundByController: false
I0907 00:04:15.572231       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6]: volume is bound to claim azuredisk-5466/pvc-8tt77
I0907 00:04:15.572243       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6]: claim azuredisk-5466/pvc-8tt77 not found
I0907 00:04:15.572412       1 pv_protection_controller.go:198] Got event on PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6
I0907 00:04:15.575858       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6: Operation cannot be fulfilled on persistentvolumes "pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6": the object has been modified; please apply your changes to the latest version and try again
I0907 00:04:15.576007       1 pv_protection_controller.go:124] Finished processing PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6 (11.021742ms)
E0907 00:04:15.576031       1 pv_protection_controller.go:114] PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6 failed with : Operation cannot be fulfilled on persistentvolumes "pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6": the object has been modified; please apply your changes to the latest version and try again
I0907 00:04:15.576150       1 pv_protection_controller.go:121] Processing PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6
I0907 00:04:15.579945       1 pv_controller_base.go:238] volume "pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6" deleted
I0907 00:04:15.579996       1 pv_controller_base.go:589] deletion of claim "azuredisk-5466/pvc-8tt77" was already processed
I0907 00:04:15.580776       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6
I0907 00:04:15.580802       1 pv_protection_controller.go:124] Finished processing PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6 (4.636418ms)
I0907 00:04:15.581930       1 pv_protection_controller.go:121] Processing PV pvc-129f01c6-05e5-4a1d-883a-0197fd7055e6
... skipping 596 lines ...
I0907 00:06:17.981176       1 pv_protection_controller.go:121] Processing PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d
I0907 00:06:17.991250       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d" with version 2445
I0907 00:06:17.991298       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d]: phase: Released, bound to: "azuredisk-5356/pvc-f8ctc (uid: c3f398c5-17f1-453a-a9db-fca9e4302f5d)", boundByController: false
I0907 00:06:17.991326       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d]: volume is bound to claim azuredisk-5356/pvc-f8ctc
I0907 00:06:17.991337       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d]: claim azuredisk-5356/pvc-f8ctc not found
I0907 00:06:17.991355       1 pv_protection_controller.go:198] Got event on PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d
I0907 00:06:17.994403       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d: Operation cannot be fulfilled on persistentvolumes "pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d": the object has been modified; please apply your changes to the latest version and try again
I0907 00:06:17.994431       1 pv_protection_controller.go:124] Finished processing PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d (13.245447ms)
E0907 00:06:17.994446       1 pv_protection_controller.go:114] PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d failed with : Operation cannot be fulfilled on persistentvolumes "pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d": the object has been modified; please apply your changes to the latest version and try again
I0907 00:06:17.994691       1 pv_protection_controller.go:121] Processing PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d
I0907 00:06:18.005592       1 pv_controller_base.go:238] volume "pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d" deleted
I0907 00:06:18.005636       1 pv_controller_base.go:589] deletion of claim "azuredisk-5356/pvc-f8ctc" was already processed
I0907 00:06:18.006900       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d
I0907 00:06:18.006920       1 pv_protection_controller.go:124] Finished processing PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d (12.209143ms)
I0907 00:06:18.006949       1 pv_protection_controller.go:121] Processing PV pvc-c3f398c5-17f1-453a-a9db-fca9e4302f5d
... skipping 1006 lines ...
I0907 00:08:30.593738       1 pv_protection_controller.go:121] Processing PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3
I0907 00:08:30.599937       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3" with version 2905
I0907 00:08:30.600080       1 pv_protection_controller.go:198] Got event on PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3
I0907 00:08:30.599963       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3]: phase: Released, bound to: "azuredisk-5194/pvc-6wgcp (uid: 470dc8cc-0c65-4102-aee8-cc0e1e95dea3)", boundByController: false
I0907 00:08:30.600765       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3]: volume is bound to claim azuredisk-5194/pvc-6wgcp
I0907 00:08:30.600785       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3]: claim azuredisk-5194/pvc-6wgcp not found
I0907 00:08:30.603379       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3: Operation cannot be fulfilled on persistentvolumes "pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3": the object has been modified; please apply your changes to the latest version and try again
I0907 00:08:30.603399       1 pv_protection_controller.go:124] Finished processing PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3 (9.625728ms)
E0907 00:08:30.603412       1 pv_protection_controller.go:114] PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3 failed with : Operation cannot be fulfilled on persistentvolumes "pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3": the object has been modified; please apply your changes to the latest version and try again
I0907 00:08:30.603690       1 pv_protection_controller.go:121] Processing PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3
I0907 00:08:30.608689       1 pv_controller_base.go:238] volume "pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3" deleted
I0907 00:08:30.609293       1 pv_controller_base.go:589] deletion of claim "azuredisk-5194/pvc-6wgcp" was already processed
I0907 00:08:30.609214       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3
I0907 00:08:30.609578       1 pv_protection_controller.go:124] Finished processing PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3 (5.865117ms)
I0907 00:08:30.609696       1 pv_protection_controller.go:121] Processing PV pvc-470dc8cc-0c65-4102-aee8-cc0e1e95dea3
... skipping 282 lines ...
I0907 00:09:35.802682       1 pv_protection_controller.go:121] Processing PV pvc-34984649-eadf-404b-beb0-328180ad9c7e
I0907 00:09:35.809578       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-34984649-eadf-404b-beb0-328180ad9c7e" with version 3090
I0907 00:09:35.809903       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-34984649-eadf-404b-beb0-328180ad9c7e]: phase: Released, bound to: "azuredisk-5194/pvc-7plqq (uid: 34984649-eadf-404b-beb0-328180ad9c7e)", boundByController: false
I0907 00:09:35.810227       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-34984649-eadf-404b-beb0-328180ad9c7e]: volume is bound to claim azuredisk-5194/pvc-7plqq
I0907 00:09:35.810477       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-34984649-eadf-404b-beb0-328180ad9c7e]: claim azuredisk-5194/pvc-7plqq not found
I0907 00:09:35.810691       1 pv_protection_controller.go:198] Got event on PV pvc-34984649-eadf-404b-beb0-328180ad9c7e
I0907 00:09:35.813656       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-34984649-eadf-404b-beb0-328180ad9c7e: Operation cannot be fulfilled on persistentvolumes "pvc-34984649-eadf-404b-beb0-328180ad9c7e": the object has been modified; please apply your changes to the latest version and try again
I0907 00:09:35.813927       1 pv_protection_controller.go:124] Finished processing PV pvc-34984649-eadf-404b-beb0-328180ad9c7e (11.024038ms)
E0907 00:09:35.813954       1 pv_protection_controller.go:114] PV pvc-34984649-eadf-404b-beb0-328180ad9c7e failed with : Operation cannot be fulfilled on persistentvolumes "pvc-34984649-eadf-404b-beb0-328180ad9c7e": the object has been modified; please apply your changes to the latest version and try again
I0907 00:09:35.813995       1 pv_protection_controller.go:121] Processing PV pvc-34984649-eadf-404b-beb0-328180ad9c7e
I0907 00:09:35.818399       1 pv_controller_base.go:238] volume "pvc-34984649-eadf-404b-beb0-328180ad9c7e" deleted
I0907 00:09:35.818625       1 pv_controller_base.go:589] deletion of claim "azuredisk-5194/pvc-7plqq" was already processed
I0907 00:09:35.820008       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-34984649-eadf-404b-beb0-328180ad9c7e
I0907 00:09:35.820436       1 pv_protection_controller.go:124] Finished processing PV pvc-34984649-eadf-404b-beb0-328180ad9c7e (6.426022ms)
I0907 00:09:35.820492       1 pv_protection_controller.go:121] Processing PV pvc-34984649-eadf-404b-beb0-328180ad9c7e
... skipping 216 lines ...
I0907 00:10:40.928659       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81]: claim azuredisk-5194/pvc-bwrx6 not found
I0907 00:10:40.935315       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81" with version 3271
I0907 00:10:40.935355       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81]: phase: Released, bound to: "azuredisk-5194/pvc-bwrx6 (uid: dfcf474a-64ab-4e3c-a95c-65c2725d6a81)", boundByController: false
I0907 00:10:40.935509       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81]: volume is bound to claim azuredisk-5194/pvc-bwrx6
I0907 00:10:40.935712       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81]: claim azuredisk-5194/pvc-bwrx6 not found
I0907 00:10:40.935821       1 pv_protection_controller.go:198] Got event on PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81
I0907 00:10:40.945089       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81: Operation cannot be fulfilled on persistentvolumes "pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81": the object has been modified; please apply your changes to the latest version and try again
I0907 00:10:40.945118       1 pv_protection_controller.go:124] Finished processing PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81 (17.822759ms)
E0907 00:10:40.945173       1 pv_protection_controller.go:114] PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81 failed with : Operation cannot be fulfilled on persistentvolumes "pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81": the object has been modified; please apply your changes to the latest version and try again
I0907 00:10:40.945312       1 pv_protection_controller.go:121] Processing PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81
I0907 00:10:40.953854       1 pv_controller_base.go:238] volume "pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81" deleted
I0907 00:10:40.954092       1 pv_controller_base.go:589] deletion of claim "azuredisk-5194/pvc-bwrx6" was already processed
I0907 00:10:40.954451       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81
I0907 00:10:40.954478       1 pv_protection_controller.go:124] Finished processing PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81 (9.08633ms)
I0907 00:10:40.954495       1 pv_protection_controller.go:121] Processing PV pvc-dfcf474a-64ab-4e3c-a95c-65c2725d6a81
... skipping 29 lines ...
I0907 00:10:44.550091       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54-4vz2f" podUID=fc861d85-9505-46f5-a062-c2e7a1640796
I0907 00:10:44.550163       1 pvc_protection_controller.go:149] "Processing PVC" PVC="azuredisk-1353/pvc-6rnfm"
I0907 00:10:44.550188       1 pvc_protection_controller.go:152] "Finished processing PVC" PVC="azuredisk-1353/pvc-6rnfm" duration="5.8µs"
I0907 00:10:44.550574       1 controller_utils.go:581] Controller azuredisk-volume-tester-tn5vv-5b9db94f54 created pod azuredisk-volume-tester-tn5vv-5b9db94f54-4vz2f
I0907 00:10:44.550640       1 replica_set_utils.go:59] Updating status for : azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54, replicas 0->0 (need 1), fullyLabeledReplicas 0->0, readyReplicas 0->0, availableReplicas 0->0, sequence No: 0->1
I0907 00:10:44.551740       1 deployment_controller.go:585] "Finished syncing deployment" deployment="azuredisk-1353/azuredisk-volume-tester-tn5vv" duration="32.753608ms"
I0907 00:10:44.551782       1 deployment_controller.go:497] "Error syncing deployment" deployment="azuredisk-1353/azuredisk-volume-tester-tn5vv" err="Operation cannot be fulfilled on deployments.apps \"azuredisk-volume-tester-tn5vv\": the object has been modified; please apply your changes to the latest version and try again"
I0907 00:10:44.551821       1 deployment_controller.go:583] "Started syncing deployment" deployment="azuredisk-1353/azuredisk-volume-tester-tn5vv" startTime="2022-09-07 00:10:44.55180302 +0000 UTC m=+877.166115391"
I0907 00:10:44.552436       1 deployment_util.go:775] Deployment "azuredisk-volume-tester-tn5vv" timed out (false) [last progress check: 2022-09-07 00:10:44 +0000 UTC - now: 2022-09-07 00:10:44.552427622 +0000 UTC m=+877.166739993]
I0907 00:10:44.553135       1 event.go:294] "Event occurred" object="azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: azuredisk-volume-tester-tn5vv-5b9db94f54-4vz2f"
I0907 00:10:44.559537       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54"
I0907 00:10:44.559876       1 replica_set.go:667] Finished syncing ReplicaSet "azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54" (27.42879ms)
I0907 00:10:44.559918       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54", timestamp:time.Time{wall:0xc0be16411fc0c4ae, ext:877147039429, loc:(*time.Location)(0x6f10040)}}
... skipping 242 lines ...
I0907 00:11:05.474092       1 disruption.go:570] No PodDisruptionBudgets found for pod azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk, PodDisruptionBudget controller will avoid syncing.
I0907 00:11:05.474101       1 disruption.go:497] No matching pdb for pod "azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk"
I0907 00:11:05.474148       1 replica_set.go:457] Pod azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk updated, objectMeta {Name:azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk GenerateName:azuredisk-volume-tester-tn5vv-5b9db94f54- Namespace:azuredisk-1353 SelfLink: UID:563b486a-455f-40b3-b443-794f9ca449b8 ResourceVersion:3420 Generation:0 CreationTimestamp:2022-09-07 00:11:05 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:azuredisk-volume-tester-2050257992909156333 pod-template-hash:5b9db94f54] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:azuredisk-volume-tester-tn5vv-5b9db94f54 UID:53c92d8d-6388-43f5-bb5d-358b082d9063 Controller:0xc000407347 BlockOwnerDeletion:0xc000407348}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-07 00:11:05 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"53c92d8d-6388-43f5-bb5d-358b082d9063\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"volume-tester\"}":{".":{},"f:args":{},"f:command":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/mnt/test-1\"}":{".":{},"f:mountPath":{},"f:name":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:terminationGracePeriodSeconds":{},"f:volumes":{".":{},"k:{\"name\":\"test-volume-1\"}":{".":{},"f:name":{},"f:persistentVolumeClaim":{".":{},"f:claimName":{}}}}}} Subresource:}]} -> {Name:azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk GenerateName:azuredisk-volume-tester-tn5vv-5b9db94f54- Namespace:azuredisk-1353 SelfLink: UID:563b486a-455f-40b3-b443-794f9ca449b8 ResourceVersion:3427 Generation:0 CreationTimestamp:2022-09-07 00:11:05 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:azuredisk-volume-tester-2050257992909156333 pod-template-hash:5b9db94f54] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:azuredisk-volume-tester-tn5vv-5b9db94f54 UID:53c92d8d-6388-43f5-bb5d-358b082d9063 Controller:0xc002a3488e BlockOwnerDeletion:0xc002a3488f}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-07 00:11:05 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"53c92d8d-6388-43f5-bb5d-358b082d9063\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"volume-tester\"}":{".":{},"f:args":{},"f:command":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/mnt/test-1\"}":{".":{},"f:mountPath":{},"f:name":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:terminationGracePeriodSeconds":{},"f:volumes":{".":{},"k:{\"name\":\"test-volume-1\"}":{".":{},"f:name":{},"f:persistentVolumeClaim":{".":{},"f:claimName":{}}}}}} Subresource:} {Manager:kubelet Operation:Update APIVersion:v1 Time:2022-09-07 00:11:05 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{"k:{\"type\":\"ContainersReady\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}},"k:{\"type\":\"Initialized\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:status":{},"f:type":{}},"k:{\"type\":\"Ready\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}},"f:containerStatuses":{},"f:hostIP":{},"f:startTime":{}}} Subresource:status}]}.
I0907 00:11:05.474278       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54", timestamp:time.Time{wall:0xc0be1646586e372f, ext:898024188642, loc:(*time.Location)(0x6f10040)}}
I0907 00:11:05.474322       1 controller_utils.go:938] Ignoring inactive pod azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54-4vz2f in state Running, deletion time 2022-09-07 00:11:35 +0000 UTC
I0907 00:11:05.474374       1 replica_set.go:667] Finished syncing ReplicaSet "azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54" (100.4µs)
I0907 00:11:05.498237       1 reconciler.go:420] "Multi-Attach error: volume is already used by pods" pods=[azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54-4vz2f] attachedTo=[capz-nlyx1d-mp-0000000] volume={VolumeToAttach:{MultiAttachErrorReported:false VolumeName:kubernetes.io/csi/disk.csi.azure.com^/subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-nlyx1d/providers/Microsoft.Compute/disks/pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed VolumeSpec:0xc0029b7968 NodeName:capz-nlyx1d-mp-0000001 ScheduledPods:[&Pod{ObjectMeta:{azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk azuredisk-volume-tester-tn5vv-5b9db94f54- azuredisk-1353  563b486a-455f-40b3-b443-794f9ca449b8 3420 0 2022-09-07 00:11:05 +0000 UTC <nil> <nil> map[app:azuredisk-volume-tester-2050257992909156333 pod-template-hash:5b9db94f54] map[] [{apps/v1 ReplicaSet azuredisk-volume-tester-tn5vv-5b9db94f54 53c92d8d-6388-43f5-bb5d-358b082d9063 0xc000407347 0xc000407348}] [] [{kube-controller-manager Update v1 2022-09-07 00:11:05 +0000 UTC FieldsV1 {"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"53c92d8d-6388-43f5-bb5d-358b082d9063\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"volume-tester\"}":{".":{},"f:args":{},"f:command":{},"f:image":{},"f:imagePullPolicy":{},"f:name":{},"f:resources":{},"f:terminationMessagePath":{},"f:terminationMessagePolicy":{},"f:volumeMounts":{".":{},"k:{\"mountPath\":\"/mnt/test-1\"}":{".":{},"f:mountPath":{},"f:name":{}}}}},"f:dnsPolicy":{},"f:enableServiceLinks":{},"f:nodeSelector":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:terminationGracePeriodSeconds":{},"f:volumes":{".":{},"k:{\"name\":\"test-volume-1\"}":{".":{},"f:name":{},"f:persistentVolumeClaim":{".":{},"f:claimName":{}}}}}} }]},Spec:PodSpec{Volumes:[]Volume{Volume{Name:test-volume-1,VolumeSource:VolumeSource{HostPath:nil,EmptyDir:nil,GCEPersistentDisk:nil,AWSElasticBlockStore:nil,GitRepo:nil,Secret:nil,NFS:nil,ISCSI:nil,Glusterfs:nil,PersistentVolumeClaim:&PersistentVolumeClaimVolumeSource{ClaimName:pvc-6rnfm,ReadOnly:false,},RBD:nil,FlexVolume:nil,Cinder:nil,CephFS:nil,Flocker:nil,DownwardAPI:nil,FC:nil,AzureFile:nil,ConfigMap:nil,VsphereVolume:nil,Quobyte:nil,AzureDisk:nil,PhotonPersistentDisk:nil,PortworxVolume:nil,ScaleIO:nil,Projected:nil,StorageOS:nil,CSI:nil,Ephemeral:nil,},},Volume{Name:kube-api-access-w4q6v,VolumeSource:VolumeSource{HostPath:nil,EmptyDir:nil,GCEPersistentDisk:nil,AWSElasticBlockStore:nil,GitRepo:nil,Secret:nil,NFS:nil,ISCSI:nil,Glusterfs:nil,PersistentVolumeClaim:nil,RBD:nil,FlexVolume:nil,Cinder:nil,CephFS:nil,Flocker:nil,DownwardAPI:nil,FC:nil,AzureFile:nil,ConfigMap:nil,VsphereVolume:nil,Quobyte:nil,AzureDisk:nil,PhotonPersistentDisk:nil,PortworxVolume:nil,ScaleIO:nil,Projected:&ProjectedVolumeSource{Sources:[]VolumeProjection{VolumeProjection{Secret:nil,DownwardAPI:nil,ConfigMap:nil,ServiceAccountToken:&ServiceAccountTokenProjection{Audience:,ExpirationSeconds:*3607,Path:token,},},VolumeProjection{Secret:nil,DownwardAPI:nil,ConfigMap:&ConfigMapProjection{LocalObjectReference:LocalObjectReference{Name:kube-root-ca.crt,},Items:[]KeyToPath{KeyToPath{Key:ca.crt,Path:ca.crt,Mode:nil,},},Optional:nil,},ServiceAccountToken:nil,},VolumeProjection{Secret:nil,DownwardAPI:&DownwardAPIProjection{Items:[]DownwardAPIVolumeFile{DownwardAPIVolumeFile{Path:namespace,FieldRef:&ObjectFieldSelector{APIVersion:v1,FieldPath:metadata.namespace,},ResourceFieldRef:nil,Mode:nil,},},},ConfigMap:nil,ServiceAccountToken:nil,},},DefaultMode:*420,},StorageOS:nil,CSI:nil,Ephemeral:nil,},},},Containers:[]Container{Container{Name:volume-tester,Image:k8s.gcr.io/e2e-test-images/busybox:1.29-2,Command:[/bin/sh],Args:[-c echo 'hello world' >> /mnt/test-1/data && while true; do sleep 3600; done],WorkingDir:,Ports:[]ContainerPort{},Env:[]EnvVar{},Resources:ResourceRequirements{Limits:ResourceList{},Requests:ResourceList{},},VolumeMounts:[]VolumeMount{VolumeMount{Name:test-volume-1,ReadOnly:false,MountPath:/mnt/test-1,SubPath:,MountPropagation:nil,SubPathExpr:,},VolumeMount{Name:kube-api-access-w4q6v,ReadOnly:true,MountPath:/var/run/secrets/kubernetes.io/serviceaccount,SubPath:,MountPropagation:nil,SubPathExpr:,},},LivenessProbe:nil,ReadinessProbe:nil,Lifecycle:nil,TerminationMessagePath:/dev/termination-log,ImagePullPolicy:IfNotPresent,SecurityContext:nil,Stdin:false,StdinOnce:false,TTY:false,EnvFrom:[]EnvFromSource{},TerminationMessagePolicy:File,VolumeDevices:[]VolumeDevice{},StartupProbe:nil,},},RestartPolicy:Always,TerminationGracePeriodSeconds:*30,ActiveDeadlineSeconds:nil,DNSPolicy:ClusterFirst,NodeSelector:map[string]string{kubernetes.io/os: linux,},ServiceAccountName:default,DeprecatedServiceAccount:default,NodeName:capz-nlyx1d-mp-0000001,HostNetwork:false,HostPID:false,HostIPC:false,SecurityContext:&PodSecurityContext{SELinuxOptions:nil,RunAsUser:nil,RunAsNonRoot:nil,SupplementalGroups:[],FSGroup:nil,RunAsGroup:nil,Sysctls:[]Sysctl{},WindowsOptions:nil,FSGroupChangePolicy:nil,SeccompProfile:nil,},ImagePullSecrets:[]LocalObjectReference{},Hostname:,Subdomain:,Affinity:nil,SchedulerName:default-scheduler,InitContainers:[]Container{},AutomountServiceAccountToken:nil,Tolerations:[]Toleration{Toleration{Key:node.kubernetes.io/not-ready,Operator:Exists,Value:,Effect:NoExecute,TolerationSeconds:*300,},Toleration{Key:node.kubernetes.io/unreachable,Operator:Exists,Value:,Effect:NoExecute,TolerationSeconds:*300,},},HostAliases:[]HostAlias{},PriorityClassName:,Priority:*0,DNSConfig:nil,ShareProcessNamespace:nil,ReadinessGates:[]PodReadinessGate{},RuntimeClassName:nil,EnableServiceLinks:*true,PreemptionPolicy:*PreemptLowerPriority,Overhead:ResourceList{},TopologySpreadConstraints:[]TopologySpreadConstraint{},EphemeralContainers:[]EphemeralContainer{},SetHostnameAsFQDN:nil,OS:nil,HostUsers:nil,},Status:PodStatus{Phase:Pending,Conditions:[]PodCondition{PodCondition{Type:PodScheduled,Status:True,LastProbeTime:0001-01-01 00:00:00 +0000 UTC,LastTransitionTime:2022-09-07 00:11:05 +0000 UTC,Reason:,Message:,},},Message:,Reason:,HostIP:,PodIP:,StartTime:<nil>,ContainerStatuses:[]ContainerStatus{},QOSClass:BestEffort,InitContainerStatuses:[]ContainerStatus{},NominatedNodeName:,PodIPs:[]PodIP{},EphemeralContainerStatuses:[]ContainerStatus{},},}]}}
I0907 00:11:05.498297       1 event.go:294] "Event occurred" object="azuredisk-1353/azuredisk-volume-tester-tn5vv-5b9db94f54-j46qk" fieldPath="" kind="Pod" apiVersion="v1" type="Warning" reason="FailedAttachVolume" message="Multi-Attach error for volume \"pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed\" Volume is already used by pod(s) azuredisk-volume-tester-tn5vv-5b9db94f54-4vz2f"
I0907 00:11:05.769385       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0907 00:11:05.824309       1 pv_controller_base.go:612] resyncing PV controller
I0907 00:11:05.824479       1 pv_controller_base.go:726] storeObjectUpdate updating claim "azuredisk-1353/pvc-6rnfm" with version 3317
I0907 00:11:05.824510       1 pv_controller.go:255] synchronizing PersistentVolumeClaim[azuredisk-1353/pvc-6rnfm]: phase: Bound, bound to: "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed", bindCompleted: true, boundByController: true
I0907 00:11:05.824584       1 pv_controller.go:511] synchronizing bound PersistentVolumeClaim[azuredisk-1353/pvc-6rnfm]: volume "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed" found: phase: Bound, bound to: "azuredisk-1353/pvc-6rnfm (uid: 2c3f775a-7c25-4046-8ded-9b8b2f8709ed)", boundByController: false
I0907 00:11:05.824598       1 pv_controller.go:528] synchronizing bound PersistentVolumeClaim[azuredisk-1353/pvc-6rnfm]: claim is already correctly bound
... skipping 440 lines ...
I0907 00:13:20.085541       1 pv_protection_controller.go:121] Processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed
I0907 00:13:20.095564       1 pv_protection_controller.go:198] Got event on PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed
I0907 00:13:20.095562       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed" with version 3805
I0907 00:13:20.095899       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed]: phase: Released, bound to: "azuredisk-1353/pvc-6rnfm (uid: 2c3f775a-7c25-4046-8ded-9b8b2f8709ed)", boundByController: false
I0907 00:13:20.096082       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed]: volume is bound to claim azuredisk-1353/pvc-6rnfm
I0907 00:13:20.096112       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed]: claim azuredisk-1353/pvc-6rnfm not found
I0907 00:13:20.105577       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed: Operation cannot be fulfilled on persistentvolumes "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed": the object has been modified; please apply your changes to the latest version and try again
I0907 00:13:20.105612       1 pv_protection_controller.go:124] Finished processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed (20.059064ms)
E0907 00:13:20.105631       1 pv_protection_controller.go:114] PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed failed with : Operation cannot be fulfilled on persistentvolumes "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed": the object has been modified; please apply your changes to the latest version and try again
I0907 00:13:20.105774       1 pv_protection_controller.go:121] Processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed
I0907 00:13:20.111716       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed
I0907 00:13:20.111892       1 pv_protection_controller.go:124] Finished processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed (5.769619ms)
I0907 00:13:20.111944       1 pv_protection_controller.go:121] Processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed
I0907 00:13:20.113590       1 pv_controller_base.go:238] volume "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed" deleted
I0907 00:13:20.113930       1 pv_controller_base.go:589] deletion of claim "azuredisk-1353/pvc-6rnfm" was already processed
I0907 00:13:20.115918       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed: Operation cannot be fulfilled on persistentvolumes "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed": StorageError: invalid object, Code: 4, Key: /registry/persistentvolumes/pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed, ResourceVersion: 0, AdditionalErrorMsg: Precondition failed: UID in precondition: e873e4bf-78f1-4dc9-8981-1b054a69c83d, UID in object meta: 
I0907 00:13:20.116106       1 pv_protection_controller.go:124] Finished processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed (3.978712ms)
E0907 00:13:20.116273       1 pv_protection_controller.go:114] PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed failed with : Operation cannot be fulfilled on persistentvolumes "pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed": StorageError: invalid object, Code: 4, Key: /registry/persistentvolumes/pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed, ResourceVersion: 0, AdditionalErrorMsg: Precondition failed: UID in precondition: e873e4bf-78f1-4dc9-8981-1b054a69c83d, UID in object meta: 
I0907 00:13:20.121603       1 pv_protection_controller.go:121] Processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed
I0907 00:13:20.121635       1 pv_protection_controller.go:129] PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed not found, ignoring
I0907 00:13:20.121645       1 pv_protection_controller.go:124] Finished processing PV pvc-2c3f775a-7c25-4046-8ded-9b8b2f8709ed (16.5µs)
I0907 00:13:20.741968       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0907 00:13:20.774434       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0907 00:13:20.832210       1 pv_controller_base.go:612] resyncing PV controller
... skipping 1066 lines ...
I0907 00:15:13.497445       1 reflector.go:559] vendor/k8s.io/client-go/metadata/metadatainformer/informer.go:90: Watch close - *v1.PartialObjectMetadata total 10 items received
I0907 00:15:18.977300       1 reflector.go:559] vendor/k8s.io/client-go/metadata/metadatainformer/informer.go:90: Watch close - *v1.PartialObjectMetadata total 9 items received
I0907 00:15:19.478375       1 httplog.go:131] "HTTP" verb="GET" URI="/healthz" latency="417.102µs" userAgent="kube-probe/1.26+" audit-ID="" srcIP="127.0.0.1:44336" resp=200
I0907 00:15:19.817279       1 csi_attacher.go:474] kubernetes.io/csi: VolumeAttachment object [csi-28d1f4723b4fccda65e004d5a5e30ae039fda635fb7f086997803940872fc72c] for volume [/subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-nlyx1d/providers/Microsoft.Compute/disks/pvc-0a50bea5-ebfe-409d-b9d3-ccf2b37e3a75] not found, object deleted
I0907 00:15:19.817334       1 operation_generator.go:513] DetachVolume.Detach succeeded for volume "pvc-0a50bea5-ebfe-409d-b9d3-ccf2b37e3a75" (UniqueName: "kubernetes.io/csi/disk.csi.azure.com^/subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-nlyx1d/providers/Microsoft.Compute/disks/pvc-0a50bea5-ebfe-409d-b9d3-ccf2b37e3a75") on node "capz-nlyx1d-mp-0000000" 
I0907 00:15:19.950629       1 csi_attacher.go:208] kubernetes.io/csi: probing attachment status for 1 volume(s) 
I0907 00:15:19.950709       1 csi_attacher.go:245] kubernetes.io/csi: attacher.VolumesAreAttached failed in AttachmentLister for attach.ID=csi-dd0aa37d8f284b22cbcb6d2dd5c024940ca22bfa2c5b898925bb957b102afc1a: volumeattachment.storage.k8s.io "csi-dd0aa37d8f284b22cbcb6d2dd5c024940ca22bfa2c5b898925bb957b102afc1a" not found. Probing the API server.
I0907 00:15:19.950726       1 csi_attacher.go:249] kubernetes.io/csi: probing attachment status for VolumeAttachment csi-dd0aa37d8f284b22cbcb6d2dd5c024940ca22bfa2c5b898925bb957b102afc1a
E0907 00:15:19.954078       1 csi_attacher.go:253] kubernetes.io/csi: attacher.VolumesAreAttached failed for attach.ID=csi-dd0aa37d8f284b22cbcb6d2dd5c024940ca22bfa2c5b898925bb957b102afc1a: volumeattachments.storage.k8s.io "csi-dd0aa37d8f284b22cbcb6d2dd5c024940ca22bfa2c5b898925bb957b102afc1a" not found
I0907 00:15:19.954120       1 operation_generator.go:254] VerifyVolumesAreAttached determined volume "kubernetes.io/csi/disk.csi.azure.com^/subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-nlyx1d/providers/Microsoft.Compute/disks/pvc-ac5ff4f1-7dd0-468a-a741-58f7a179e045" (spec.Name: "pvc-ac5ff4f1-7dd0-468a-a741-58f7a179e045") is no longer attached to node "capz-nlyx1d-mp-0000000", therefore it was marked as detached.
I0907 00:15:20.020352       1 csi_attacher.go:474] kubernetes.io/csi: VolumeAttachment object [csi-dd0aa37d8f284b22cbcb6d2dd5c024940ca22bfa2c5b898925bb957b102afc1a] for volume [/subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-nlyx1d/providers/Microsoft.Compute/disks/pvc-ac5ff4f1-7dd0-468a-a741-58f7a179e045] not found, object deleted
I0907 00:15:20.020404       1 operation_generator.go:513] DetachVolume.Detach succeeded for volume "pvc-ac5ff4f1-7dd0-468a-a741-58f7a179e045" (UniqueName: "kubernetes.io/csi/disk.csi.azure.com^/subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-nlyx1d/providers/Microsoft.Compute/disks/pvc-ac5ff4f1-7dd0-468a-a741-58f7a179e045") on node "capz-nlyx1d-mp-0000000" 
I0907 00:15:20.747181       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0907 00:15:20.780224       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0907 00:15:20.839455       1 pv_controller_base.go:612] resyncing PV controller
... skipping 1815 lines ...
I0907 00:18:52.255748       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729]: volume is bound to claim azuredisk-8582/pvc-2c2vf
I0907 00:18:52.255770       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729]: claim azuredisk-8582/pvc-2c2vf not found
I0907 00:18:52.270674       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729" with version 5063
I0907 00:18:52.270870       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729]: phase: Released, bound to: "azuredisk-8582/pvc-2c2vf (uid: e3fb7b36-8113-4b83-9c9f-b4a19b7c7729)", boundByController: false
I0907 00:18:52.270923       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729]: volume is bound to claim azuredisk-8582/pvc-2c2vf
I0907 00:18:52.270934       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729]: claim azuredisk-8582/pvc-2c2vf not found
I0907 00:18:52.271014       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729: Operation cannot be fulfilled on persistentvolumes "pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729": the object has been modified; please apply your changes to the latest version and try again
I0907 00:18:52.271025       1 pv_protection_controller.go:198] Got event on PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729
I0907 00:18:52.271097       1 pv_protection_controller.go:124] Finished processing PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729 (15.739701ms)
E0907 00:18:52.271206       1 pv_protection_controller.go:114] PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729 failed with : Operation cannot be fulfilled on persistentvolumes "pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729": the object has been modified; please apply your changes to the latest version and try again
I0907 00:18:52.271383       1 pv_protection_controller.go:121] Processing PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729
I0907 00:18:52.276783       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729
I0907 00:18:52.277492       1 pv_protection_controller.go:124] Finished processing PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729 (5.925438ms)
I0907 00:18:52.277522       1 pv_protection_controller.go:121] Processing PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729
I0907 00:18:52.277533       1 pv_protection_controller.go:129] PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729 not found, ignoring
I0907 00:18:52.277539       1 pv_protection_controller.go:124] Finished processing PV pvc-e3fb7b36-8113-4b83-9c9f-b4a19b7c7729 (10.4µs)
... skipping 556 lines ...
I0907 00:20:28.089341       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd]: claim azuredisk-7051/pvc-4ftb4 not found
I0907 00:20:28.106993       1 pv_controller_base.go:726] storeObjectUpdate updating volume "pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd" with version 5420
I0907 00:20:28.107400       1 pv_protection_controller.go:198] Got event on PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd
I0907 00:20:28.107349       1 pv_controller.go:551] synchronizing PersistentVolume[pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd]: phase: Released, bound to: "azuredisk-7051/pvc-4ftb4 (uid: 44d22fd8-c940-4f2a-9bf0-f375c4875bbd)", boundByController: false
I0907 00:20:28.107905       1 pv_controller.go:585] synchronizing PersistentVolume[pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd]: volume is bound to claim azuredisk-7051/pvc-4ftb4
I0907 00:20:28.108375       1 pv_controller.go:619] synchronizing PersistentVolume[pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd]: claim azuredisk-7051/pvc-4ftb4 not found
I0907 00:20:28.108131       1 pv_protection_controller.go:173] Error removing protection finalizer from PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd: Operation cannot be fulfilled on persistentvolumes "pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd": the object has been modified; please apply your changes to the latest version and try again
I0907 00:20:28.108407       1 pv_protection_controller.go:124] Finished processing PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd (19.740278ms)
E0907 00:20:28.108496       1 pv_protection_controller.go:114] PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd failed with : Operation cannot be fulfilled on persistentvolumes "pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd": the object has been modified; please apply your changes to the latest version and try again
I0907 00:20:28.108532       1 pv_protection_controller.go:121] Processing PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd
I0907 00:20:28.113595       1 pv_controller_base.go:238] volume "pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd" deleted
I0907 00:20:28.113669       1 pv_controller_base.go:589] deletion of claim "azuredisk-7051/pvc-4ftb4" was already processed
I0907 00:20:28.114004       1 pv_protection_controller.go:176] Removed protection finalizer from PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd
I0907 00:20:28.114026       1 pv_protection_controller.go:124] Finished processing PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd (5.483821ms)
I0907 00:20:28.114069       1 pv_protection_controller.go:121] Processing PV pvc-44d22fd8-c940-4f2a-9bf0-f375c4875bbd
... skipping 591 lines ...
I0907 00:21:59.864804       1 serviceaccounts_controller.go:188] Finished syncing namespace "azuredisk-9183" (1.7µs)
2022/09/07 00:22:00 ===================================================

JUnit report was created: /logs/artifacts/junit_01.xml

Ran 12 of 59 Specs in 1288.644 seconds
SUCCESS! -- 12 Passed | 0 Failed | 0 Pending | 47 Skipped

You're using deprecated Ginkgo functionality:
=============================================
Ginkgo 2.0 is under active development and will introduce several new features, improvements, and a small handful of breaking changes.
A release candidate for 2.0 is now available and 2.0 should GA in Fall 2021.  Please give the RC a try and send us feedback!
  - To learn more, view the migration guide at https://github.com/onsi/ginkgo/blob/ver2/docs/MIGRATING_TO_V2.md
... skipping 44 lines ...
INFO: Creating log watcher for controller capz-system/capz-controller-manager, pod capz-controller-manager-858df9cd95-sfpq9, container manager
STEP: Dumping workload cluster default/capz-nlyx1d logs
Sep  7 00:23:30.928: INFO: Collecting logs for Linux node capz-nlyx1d-control-plane-jp9jl in cluster capz-nlyx1d in namespace default

Sep  7 00:24:30.929: INFO: Collecting boot logs for AzureMachine capz-nlyx1d-control-plane-jp9jl

Failed to get logs for machine capz-nlyx1d-control-plane-992h9, cluster default/capz-nlyx1d: open /etc/azure-ssh/azure-ssh: no such file or directory
Sep  7 00:24:32.285: INFO: Collecting logs for Linux node capz-nlyx1d-mp-0000000 in cluster capz-nlyx1d in namespace default

Sep  7 00:25:32.287: INFO: Collecting boot logs for VMSS instance 0 of scale set capz-nlyx1d-mp-0

Sep  7 00:25:32.594: INFO: Collecting logs for Linux node capz-nlyx1d-mp-0000001 in cluster capz-nlyx1d in namespace default

Sep  7 00:26:32.595: INFO: Collecting boot logs for VMSS instance 1 of scale set capz-nlyx1d-mp-0

Failed to get logs for machine pool capz-nlyx1d-mp-0, cluster default/capz-nlyx1d: open /etc/azure-ssh/azure-ssh: no such file or directory
STEP: Dumping workload cluster default/capz-nlyx1d kube-system pod logs
STEP: Creating log watcher for controller kube-system/calico-node-bndkr, container calico-node
STEP: Fetching kube-system pod logs took 392.710993ms
STEP: Dumping workload cluster default/capz-nlyx1d Azure activity log
STEP: Creating log watcher for controller kube-system/calico-kube-controllers-755ff8d7b5-78cgz, container calico-kube-controllers
STEP: Creating log watcher for controller kube-system/calico-node-q8dvn, container calico-node
... skipping 71 lines ...