This job view page is being replaced by Spyglass soon. Check out the new job view.
Resultsuccess
Tests 0 failed / 6 succeeded
Started2022-09-08 09:27
Elapsed36m12s
Revision
uploadercrier

No Test Failures!


Show 6 Passed Tests

Show 28 Skipped Tests

Error lines from build-log.txt

... skipping 704 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 141 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-4toi8r-kubeconfig; do sleep 1; done"
capz-4toi8r-kubeconfig                 cluster.x-k8s.io/secret   1      1s
# 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-4toi8r-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-4toi8r-control-plane-2z585   NotReady   <none>   1s    v1.26.0-alpha.0.439+8287e21228e9b1
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-4toi8r-control-plane-2z585 condition met
node/capz-4toi8r-md-0-2tfwf condition met
... skipping 63 lines ...
Dynamic Provisioning 
  should create a storage account with tags [file.csi.azure.com] [Windows]
  /home/prow/go/src/sigs.k8s.io/azurefile-csi-driver/test/e2e/dynamic_provisioning_test.go:73
STEP: Creating a kubernetes client
Sep  8 09:45:19.502: INFO: >>> kubeConfig: /home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/kubeconfig
STEP: Building a namespace api object, basename azurefile
Sep  8 09:45:20.188: 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/08 09:45:20 Check driver pods if restarts ...
check the driver pods if restarts ...
======================================================================================
2022/09/08 09:45:21 Check successfully
... skipping 44 lines ...
Sep  8 09:45:43.941: INFO: PersistentVolumeClaim pvc-gx9f7 found but phase is Pending instead of Bound.
Sep  8 09:45:46.045: INFO: PersistentVolumeClaim pvc-gx9f7 found and phase=Bound (23.234306772s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pods command exits with no error
Sep  8 09:45:46.354: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-mnm6w" in namespace "azurefile-2540" to be "Succeeded or Failed"
Sep  8 09:45:46.457: INFO: Pod "azurefile-volume-tester-mnm6w": Phase="Pending", Reason="", readiness=false. Elapsed: 102.15137ms
Sep  8 09:45:48.566: INFO: Pod "azurefile-volume-tester-mnm6w": Phase="Pending", Reason="", readiness=false. Elapsed: 2.211197024s
Sep  8 09:45:50.675: INFO: Pod "azurefile-volume-tester-mnm6w": Phase="Running", Reason="", readiness=false. Elapsed: 4.320367797s
Sep  8 09:45:52.783: INFO: Pod "azurefile-volume-tester-mnm6w": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.428518683s
STEP: Saw pod success
Sep  8 09:45:52.783: INFO: Pod "azurefile-volume-tester-mnm6w" satisfied condition "Succeeded or Failed"
Sep  8 09:45:52.783: INFO: deleting Pod "azurefile-2540"/"azurefile-volume-tester-mnm6w"
Sep  8 09:45:52.897: INFO: Pod azurefile-volume-tester-mnm6w has the following logs: hello world

STEP: Deleting pod azurefile-volume-tester-mnm6w in namespace azurefile-2540
Sep  8 09:45:53.014: INFO: deleting PVC "azurefile-2540"/"pvc-gx9f7"
Sep  8 09:45:53.015: INFO: Deleting PersistentVolumeClaim "pvc-gx9f7"
... skipping 156 lines ...
Sep  8 09:47:49.213: INFO: PersistentVolumeClaim pvc-nhr6z found but phase is Pending instead of Bound.
Sep  8 09:47:51.316: INFO: PersistentVolumeClaim pvc-nhr6z found and phase=Bound (23.236977635s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pods command exits with an error
Sep  8 09:47:51.623: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-vd5lp" in namespace "azurefile-2790" to be "Error status code"
Sep  8 09:47:51.725: INFO: Pod "azurefile-volume-tester-vd5lp": Phase="Pending", Reason="", readiness=false. Elapsed: 101.934928ms
Sep  8 09:47:53.833: INFO: Pod "azurefile-volume-tester-vd5lp": Phase="Pending", Reason="", readiness=false. Elapsed: 2.209850605s
Sep  8 09:47:55.941: INFO: Pod "azurefile-volume-tester-vd5lp": Phase="Failed", Reason="", readiness=false. Elapsed: 4.318029107s
STEP: Saw pod failure
Sep  8 09:47:55.941: INFO: Pod "azurefile-volume-tester-vd5lp" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Sep  8 09:47:56.053: INFO: deleting Pod "azurefile-2790"/"azurefile-volume-tester-vd5lp"
Sep  8 09:47:56.157: INFO: Pod azurefile-volume-tester-vd5lp has the following logs: touch: /mnt/test-1/data: Read-only file system

STEP: Deleting pod azurefile-volume-tester-vd5lp in namespace azurefile-2790
Sep  8 09:47:56.272: INFO: deleting PVC "azurefile-2790"/"pvc-nhr6z"
... skipping 181 lines ...
Sep  8 09:49:58.449: INFO: PersistentVolumeClaim pvc-d5n6g found but phase is Pending instead of Bound.
Sep  8 09:50:00.552: INFO: PersistentVolumeClaim pvc-d5n6g found and phase=Bound (2.205113876s)
STEP: checking the PVC
STEP: validating provisioned PV
STEP: checking the PV
STEP: deploying the pod
STEP: checking that the pods command exits with no error
Sep  8 09:50:00.863: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-pzdhp" in namespace "azurefile-4538" to be "Succeeded or Failed"
Sep  8 09:50:00.965: INFO: Pod "azurefile-volume-tester-pzdhp": Phase="Pending", Reason="", readiness=false. Elapsed: 101.926143ms
Sep  8 09:50:03.072: INFO: Pod "azurefile-volume-tester-pzdhp": Phase="Pending", Reason="", readiness=false. Elapsed: 2.209130486s
Sep  8 09:50:05.179: INFO: Pod "azurefile-volume-tester-pzdhp": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.316253869s
STEP: Saw pod success
Sep  8 09:50:05.179: INFO: Pod "azurefile-volume-tester-pzdhp" satisfied condition "Succeeded or Failed"
STEP: resizing the pvc
STEP: sleep 30s waiting for resize complete
STEP: checking the resizing result
STEP: checking the resizing PV result
STEP: checking the resizing azurefile result
Sep  8 09:50:36.514: INFO: deleting Pod "azurefile-4538"/"azurefile-volume-tester-pzdhp"
... skipping 863 lines ...
I0908 09:39:02.209165       1 tlsconfig.go:200] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1662629941\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1662629940\" (2022-09-08 08:39:00 +0000 UTC to 2023-09-08 08:39:00 +0000 UTC (now=2022-09-08 09:39:02.209138729 +0000 UTC))"
I0908 09:39:02.209328       1 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1662629942\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1662629942\" (2022-09-08 08:39:01 +0000 UTC to 2023-09-08 08:39:01 +0000 UTC (now=2022-09-08 09:39:02.209300229 +0000 UTC))"
I0908 09:39:02.209355       1 secure_serving.go:210] Serving securely on 127.0.0.1:10257
I0908 09:39:02.209560       1 leaderelection.go:248] attempting to acquire leader lease kube-system/kube-controller-manager...
I0908 09:39:02.210190       1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I0908 09:39:02.210292       1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt"
E0908 09:39:05.659711       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"
I0908 09:39:05.661134       1 leaderelection.go:253] failed to acquire lease kube-system/kube-controller-manager
I0908 09:39:09.316874       1 leaderelection.go:258] successfully acquired lease kube-system/kube-controller-manager
I0908 09:39:09.317317       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-4toi8r-control-plane-2z585_394445b3-0513-48f5-a65d-43af52fdf15c became leader"
W0908 09:39:09.477212       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
I0908 09:39:09.478056       1 azure_auth.go:232] Using AzurePublicCloud environment
I0908 09:39:09.478188       1 azure_auth.go:117] azure: using client_id+client_secret to retrieve access token
I0908 09:39:09.478321       1 azure_interfaceclient.go:63] Azure InterfacesClient (read ops) using rate limit config: QPS=1, bucket=5
... skipping 29 lines ...
I0908 09:39:09.481405       1 reflector.go:221] Starting reflector *v1.Node (17h37m1.419437751s) from vendor/k8s.io/client-go/informers/factory.go:134
I0908 09:39:09.482160       1 reflector.go:257] Listing and watching *v1.Node from vendor/k8s.io/client-go/informers/factory.go:134
I0908 09:39:09.481508       1 reflector.go:221] Starting reflector *v1.Secret (17h37m1.419437751s) from vendor/k8s.io/client-go/informers/factory.go:134
I0908 09:39:09.482423       1 reflector.go:257] Listing and watching *v1.Secret from vendor/k8s.io/client-go/informers/factory.go:134
I0908 09:39:09.481617       1 reflector.go:221] Starting reflector *v1.ServiceAccount (17h37m1.419437751s) from vendor/k8s.io/client-go/informers/factory.go:134
I0908 09:39:09.483812       1 reflector.go:257] Listing and watching *v1.ServiceAccount from vendor/k8s.io/client-go/informers/factory.go:134
W0908 09:39:09.506429       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
I0908 09:39:09.506455       1 controllermanager.go:573] Starting "endpointslice"
I0908 09:39:09.512023       1 controllermanager.go:602] Started "endpointslice"
I0908 09:39:09.512044       1 controllermanager.go:573] Starting "podgc"
I0908 09:39:09.512280       1 endpointslice_controller.go:261] Starting endpoint slice controller
I0908 09:39:09.512297       1 shared_informer.go:273] Waiting for caches to sync for endpoint_slice
I0908 09:39:09.517216       1 controllermanager.go:602] Started "podgc"
... skipping 34 lines ...
I0908 09:39:09.634879       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/gce-pd"
I0908 09:39:09.634890       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/azure-disk"
I0908 09:39:09.634903       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/vsphere-volume"
I0908 09:39:09.634923       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/portworx-volume"
I0908 09:39:09.634935       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/fc"
I0908 09:39:09.634948       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/iscsi"
I0908 09:39:09.635149       1 csi_plugin.go:257] Cast from VolumeHost to KubeletVolumeHost failed. Skipping CSINode initialization, not running on kubelet
I0908 09:39:09.635295       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/csi"
I0908 09:39:09.635449       1 controllermanager.go:602] Started "attachdetach"
I0908 09:39:09.635538       1 controllermanager.go:573] Starting "ephemeral-volume"
I0908 09:39:09.635701       1 attach_detach_controller.go:328] Starting attach detach controller
I0908 09:39:09.635826       1 shared_informer.go:273] Waiting for caches to sync for attach detach
I0908 09:39:09.789552       1 controllermanager.go:602] Started "ephemeral-volume"
... skipping 192 lines ...
I0908 09:39:13.834734       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/gce-pd"
I0908 09:39:13.834756       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/azure-disk"
I0908 09:39:13.834769       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/vsphere-volume"
I0908 09:39:13.834795       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/portworx-volume"
I0908 09:39:13.834813       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/azure-file"
I0908 09:39:13.834829       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/local-volume"
I0908 09:39:13.834883       1 csi_plugin.go:257] Cast from VolumeHost to KubeletVolumeHost failed. Skipping CSINode initialization, not running on kubelet
I0908 09:39:13.834984       1 plugins.go:646] "Loaded volume plugin" pluginName="kubernetes.io/csi"
I0908 09:39:13.835048       1 controllermanager.go:602] Started "persistentvolume-binder"
I0908 09:39:13.835221       1 pv_controller_base.go:318] Starting persistent volume controller
I0908 09:39:13.835238       1 shared_informer.go:273] Waiting for caches to sync for persistent volume
I0908 09:39:13.837074       1 reflector.go:221] Starting reflector *v1.Ingress (17h37m1.419437751s) from vendor/k8s.io/client-go/informers/factory.go:134
I0908 09:39:13.837244       1 reflector.go:257] Listing and watching *v1.Ingress from vendor/k8s.io/client-go/informers/factory.go:134
... skipping 248 lines ...
I0908 09:39:14.187972       1 request.go:614] Waited for 283.485528ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/admissionregistration.k8s.io/v1/validatingwebhookconfigurations?limit=500&resourceVersion=0
I0908 09:39:14.203998       1 graph_builder.go:281] garbage controller monitor not yet synced: networking.k8s.io/v1, Resource=ingressclasses
I0908 09:39:14.236691       1 graph_builder.go:281] garbage controller monitor not yet synced: networking.k8s.io/v1, Resource=ingressclasses
I0908 09:39:14.237764       1 request.go:614] Waited for 333.092019ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/networking.k8s.io/v1/ingressclasses?limit=500&resourceVersion=0
I0908 09:39:14.288265       1 request.go:614] Waited for 383.509113ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/flowcontrol.apiserver.k8s.io/v1beta2/prioritylevelconfigurations?limit=500&resourceVersion=0
I0908 09:39:14.298040       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-control-plane-2z585"
W0908 09:39:14.298267       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-4toi8r-control-plane-2z585" does not exist
I0908 09:39:14.298475       1 topologycache.go:183] Ignoring node capz-4toi8r-control-plane-2z585 because it is not ready: [{MemoryPressure False 2022-09-08 09:38:50 +0000 UTC 2022-09-08 09:38:50 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-08 09:38:50 +0000 UTC 2022-09-08 09:38:50 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-08 09:38:50 +0000 UTC 2022-09-08 09:38:50 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-08 09:38:50 +0000 UTC 2022-09-08 09:38:50 +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]}]
I0908 09:39:14.298760       1 topologycache.go:215] Insufficient node info for topology hints (0 zones, %!s(int64=0) CPU, true)
I0908 09:39:14.298589       1 controller.go:690] Syncing backends for all LB services.
I0908 09:39:14.299002       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0908 09:39:14.299126       1 controller.go:753] Finished updateLoadBalancerHosts
I0908 09:39:14.299248       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0908 09:39:14.299365       1 controller.go:686] It took 0.000775602 seconds to finish syncNodes
... skipping 40 lines ...
I0908 09:39:15.577495       1 daemon_controller.go:228] Adding daemon set kube-proxy
I0908 09:39:15.578944       1 event.go:294] "Event occurred" object="kube-system/coredns" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set coredns-84994b8c4 to 2"
I0908 09:39:15.597431       1 deployment_util.go:775] Deployment "coredns" timed out (false) [last progress check: 2022-09-08 09:39:15.577167624 +0000 UTC m=+15.059923151 - now: 2022-09-08 09:39:15.597418362 +0000 UTC m=+15.080173989]
I0908 09:39:15.597543       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/coredns"
I0908 09:39:15.621517       1 endpointslice_controller.go:319] Finished syncing service "kube-system/kube-dns" endpoint slices. (61.932115ms)
I0908 09:39:15.621662       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/coredns" duration="90.154468ms"
I0908 09:39:15.621687       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"
I0908 09:39:15.621720       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/coredns" startTime="2022-09-08 09:39:15.621701107 +0000 UTC m=+15.104456634"
I0908 09:39:15.622709       1 deployment_util.go:775] Deployment "coredns" timed out (false) [last progress check: 2022-09-08 09:39:15 +0000 UTC - now: 2022-09-08 09:39:15.622700609 +0000 UTC m=+15.105456236]
I0908 09:39:15.632668       1 endpointslicemirroring_controller.go:278] syncEndpoints("kube-system/kube-dns")
I0908 09:39:15.632690       1 endpointslicemirroring_controller.go:313] kube-system/kube-dns Service now has selector, cleaning up any mirrored EndpointSlices
I0908 09:39:15.632736       1 endpointslicemirroring_controller.go:275] Finished syncing EndpointSlices for "kube-system/kube-dns" Endpoints. (74.2µs)
I0908 09:39:15.633327       1 endpoints_controller.go:369] Finished syncing service "kube-system/kube-dns" endpoints. (73.352436ms)
... skipping 149 lines ...
I0908 09:39:16.798319       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/metrics-server-76f7667fbf-5lhhv"
I0908 09:39:16.798380       1 endpoints_controller.go:369] Finished syncing service "kube-system/metrics-server" endpoints. (33.1µs)
I0908 09:39:16.800489       1 event.go:294] "Event occurred" object="kube-system/metrics-server-76f7667fbf" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: metrics-server-76f7667fbf-5lhhv"
I0908 09:39:16.798488       1 endpointslice_controller.go:319] Finished syncing service "kube-system/metrics-server" endpoint slices. (83.9µs)
I0908 09:39:16.800808       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/metrics-server"
I0908 09:39:16.815480       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="35.160966ms"
I0908 09:39:16.815685       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/metrics-server" err="Operation cannot be fulfilled on deployments.apps \"metrics-server\": the object has been modified; please apply your changes to the latest version and try again"
I0908 09:39:16.815849       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-08 09:39:16.815805028 +0000 UTC m=+16.298560555"
I0908 09:39:16.816353       1 deployment_util.go:775] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-08 09:39:16 +0000 UTC - now: 2022-09-08 09:39:16.816348229 +0000 UTC m=+16.299103856]
I0908 09:39:16.827611       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="kube-system/metrics-server-76f7667fbf"
I0908 09:39:16.828720       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/metrics-server-76f7667fbf" (43.490781ms)
I0908 09:39:16.828880       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/metrics-server-76f7667fbf", timestamp:time.Time{wall:0xc0be8bf12ece922b, ext:16268045398, loc:(*time.Location)(0x6f12040)}}
I0908 09:39:16.829120       1 replica_set_utils.go:59] Updating status for : kube-system/metrics-server-76f7667fbf, replicas 0->1 (need 1), fullyLabeledReplicas 0->1, readyReplicas 0->0, availableReplicas 0->0, sequence No: 1->1
... skipping 16 lines ...
I0908 09:39:16.843418       1 disruption.go:570] No PodDisruptionBudgets found for pod metrics-server-76f7667fbf-5lhhv, PodDisruptionBudget controller will avoid syncing.
I0908 09:39:16.843422       1 disruption.go:497] No matching pdb for pod "metrics-server-76f7667fbf-5lhhv"
I0908 09:39:16.846390       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="9.977919ms"
I0908 09:39:16.846415       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-08 09:39:16.846404385 +0000 UTC m=+16.329159912"
I0908 09:39:16.848205       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/metrics-server"
I0908 09:39:16.850787       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="4.374308ms"
I0908 09:39:16.850809       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/metrics-server" err="Operation cannot be fulfilled on deployments.apps \"metrics-server\": the object has been modified; please apply your changes to the latest version and try again"
I0908 09:39:16.850830       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-08 09:39:16.850820793 +0000 UTC m=+16.333576320"
I0908 09:39:16.851187       1 deployment_util.go:775] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-08 09:39:16 +0000 UTC - now: 2022-09-08 09:39:16.851182194 +0000 UTC m=+16.333937721]
I0908 09:39:16.851209       1 progress.go:195] Queueing up deployment "metrics-server" for a progress check after 599s
I0908 09:39:16.851222       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="395.601µs"
I0908 09:39:16.856411       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-08 09:39:16.856397504 +0000 UTC m=+16.339153031"
I0908 09:39:16.856776       1 deployment_util.go:775] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-08 09:39:16 +0000 UTC - now: 2022-09-08 09:39:16.856771904 +0000 UTC m=+16.339527431]
... skipping 192 lines ...
I0908 09:39:44.051781       1 azure_vmss.go:370] Can not extract scale set name from providerID (azure:///subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-4toi8r/providers/Microsoft.Compute/virtualMachines/capz-4toi8r-control-plane-2z585), assuming it is managed by availability set: not a vmss instance
I0908 09:39:44.051913       1 azure_vmss.go:370] Can not extract scale set name from providerID (azure:///subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-4toi8r/providers/Microsoft.Compute/virtualMachines/capz-4toi8r-control-plane-2z585), assuming it is managed by availability set: not a vmss instance
I0908 09:39:44.051964       1 azure_instances.go:240] InstanceShutdownByProviderID gets power status "running" for node "capz-4toi8r-control-plane-2z585"
I0908 09:39:44.051983       1 azure_instances.go:251] InstanceShutdownByProviderID gets provisioning state "Updating" for node "capz-4toi8r-control-plane-2z585"
E0908 09:39:44.058443       1 resource_quota_controller.go:417] unable to retrieve the complete list of server APIs: metrics.k8s.io/v1beta1: the server is currently unable to handle the request
I0908 09:39:44.058524       1 resource_quota_controller.go:432] no resource updates from discovery, skipping resource quota sync
W0908 09:39:44.419815       1 garbagecollector.go:752] failed to discover some groups: map[metrics.k8s.io/v1beta1:the server is currently unable to handle the request]
I0908 09:39:44.420009       1 garbagecollector.go:220] syncing garbage collector with updated resources from discovery (attempt 1): added: [crd.projectcalico.org/v1, Resource=bgpconfigurations crd.projectcalico.org/v1, Resource=bgppeers crd.projectcalico.org/v1, Resource=blockaffinities crd.projectcalico.org/v1, Resource=caliconodestatuses crd.projectcalico.org/v1, Resource=clusterinformations crd.projectcalico.org/v1, Resource=felixconfigurations crd.projectcalico.org/v1, Resource=globalnetworkpolicies crd.projectcalico.org/v1, Resource=globalnetworksets crd.projectcalico.org/v1, Resource=hostendpoints crd.projectcalico.org/v1, Resource=ipamblocks crd.projectcalico.org/v1, Resource=ipamconfigs], removed: []
I0908 09:39:44.420094       1 garbagecollector.go:226] reset restmapper
E0908 09:39:44.425288       1 memcache.go:206] couldn't get resource list for metrics.k8s.io/v1beta1: the server is currently unable to handle the request
E0908 09:39:44.430083       1 memcache.go:104] couldn't get resource list for metrics.k8s.io/v1beta1: the server is currently unable to handle the request
I0908 09:39:44.431564       1 graph_builder.go:176] using a shared informer for resource "crd.projectcalico.org/v1, Resource=bgpconfigurations", kind "crd.projectcalico.org/v1, Kind=BGPConfiguration"
I0908 09:39:44.431721       1 graph_builder.go:176] using a shared informer for resource "crd.projectcalico.org/v1, Resource=blockaffinities", kind "crd.projectcalico.org/v1, Kind=BlockAffinity"
... skipping 60 lines ...
I0908 09:39:46.153194       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/calico-kube-controllers-755ff8d7b5-cf4n2"
I0908 09:39:46.153182       1 replica_set.go:394] Pod calico-kube-controllers-755ff8d7b5-cf4n2 created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"calico-kube-controllers-755ff8d7b5-cf4n2", GenerateName:"calico-kube-controllers-755ff8d7b5-", Namespace:"kube-system", SelfLink:"", UID:"64bbd48f-c1e6-4564-a8a9-a73778a586db", ResourceVersion:"496", Generation:0, CreationTimestamp:time.Date(2022, time.September, 8, 9, 39, 46, 0, time.Local), DeletionTimestamp:<nil>, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"k8s-app":"calico-kube-controllers", "pod-template-hash":"755ff8d7b5"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"calico-kube-controllers-755ff8d7b5", UID:"a659f8f6-d325-4751-bd1a-b4aa3b230fb9", Controller:(*bool)(0xc0025d58ee), BlockOwnerDeletion:(*bool)(0xc0025d58ef)}}, Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:time.Date(2022, time.September, 8, 9, 39, 46, 0, time.Local), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc0025d19e0), Subresource:""}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"kube-api-access-7qtt9", 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)(0xc001fe8ec0), 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:"calico-kube-controllers", Image:"docker.io/calico/kube-controllers:v3.23.0", Command:[]string(nil), Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"ENABLED_CONTROLLERS", Value:"node", ValueFrom:(*v1.EnvVarSource)(nil)}, v1.EnvVar{Name:"DATASTORE_TYPE", Value:"kubernetes", ValueFrom:(*v1.EnvVarSource)(nil)}}, Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"kube-api-access-7qtt9", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(0xc001fda940), ReadinessProbe:(*v1.Probe)(0xc001fda980), 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)(0xc0025d59a0), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string{"kubernetes.io/os":"linux"}, ServiceAccountName:"calico-kube-controllers", DeprecatedServiceAccount:"calico-kube-controllers", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc0002ab730), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"CriticalAddonsOnly", Operator:"Exists", Value:"", Effect:"", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/master", Operator:"", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node-role.kubernetes.io/control-plane", Operator:"", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}, v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0025d5a00)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0025d5a20)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc0025d5a28), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc0025d5a2c), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc0016aae50), 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:"BestEffort", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}.
I0908 09:39:46.153993       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-kube-controllers-755ff8d7b5", timestamp:time.Time{wall:0xc0be8bf887ebab03, ext:45615640878, loc:(*time.Location)(0x6f12040)}}
I0908 09:39:46.154278       1 controller_utils.go:581] Controller calico-kube-controllers-755ff8d7b5 created pod calico-kube-controllers-755ff8d7b5-cf4n2
I0908 09:39:46.154544       1 replica_set_utils.go:59] Updating status for : kube-system/calico-kube-controllers-755ff8d7b5, replicas 0->0 (need 1), fullyLabeledReplicas 0->0, readyReplicas 0->0, availableReplicas 0->0, sequence No: 0->1
I0908 09:39:46.154481       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/calico-kube-controllers" duration="25.226886ms"
I0908 09:39:46.156258       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"
I0908 09:39:46.156297       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/calico-kube-controllers" startTime="2022-09-08 09:39:46.156281172 +0000 UTC m=+45.639036699"
I0908 09:39:46.154692       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-cf4n2"
I0908 09:39:46.156713       1 deployment_util.go:775] Deployment "calico-kube-controllers" timed out (false) [last progress check: 2022-09-08 09:39:46 +0000 UTC - now: 2022-09-08 09:39:46.156706287 +0000 UTC m=+45.639461814]
I0908 09:39:46.162524       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/calico-kube-controllers"
I0908 09:39:46.162681       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/calico-kube-controllers" duration="6.388424ms"
I0908 09:39:46.162923       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/calico-kube-controllers" startTime="2022-09-08 09:39:46.162837802 +0000 UTC m=+45.645593329"
... skipping 251 lines ...
I0908 09:40:07.763277       1 disruption.go:494] updatePod called on pod "calico-kube-controllers-755ff8d7b5-cf4n2"
I0908 09:40:07.763335       1 disruption.go:499] updatePod "calico-kube-controllers-755ff8d7b5-cf4n2" -> PDB "calico-kube-controllers"
I0908 09:40:07.763404       1 disruption.go:659] Finished syncing PodDisruptionBudget "kube-system/calico-kube-controllers" (44.4µs)
I0908 09:40:07.763435       1 replica_set.go:457] Pod calico-kube-controllers-755ff8d7b5-cf4n2 updated, objectMeta {Name:calico-kube-controllers-755ff8d7b5-cf4n2 GenerateName:calico-kube-controllers-755ff8d7b5- Namespace:kube-system SelfLink: UID:64bbd48f-c1e6-4564-a8a9-a73778a586db ResourceVersion:565 Generation:0 CreationTimestamp:2022-09-08 09:39:46 +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:a659f8f6-d325-4751-bd1a-b4aa3b230fb9 Controller:0xc001d2af0e BlockOwnerDeletion:0xc001d2af0f}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:39:46 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"a659f8f6-d325-4751-bd1a-b4aa3b230fb9\"}":{}}},"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-08 09:39:46 +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:calico-kube-controllers-755ff8d7b5-cf4n2 GenerateName:calico-kube-controllers-755ff8d7b5- Namespace:kube-system SelfLink: UID:64bbd48f-c1e6-4564-a8a9-a73778a586db ResourceVersion:573 Generation:0 CreationTimestamp:2022-09-08 09:39:46 +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:a659f8f6-d325-4751-bd1a-b4aa3b230fb9 Controller:0xc001f2eed7 BlockOwnerDeletion:0xc001f2eed8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:39:46 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"a659f8f6-d325-4751-bd1a-b4aa3b230fb9\"}":{}}},"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-08 09:39:46 +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-08 09:40:07 +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}]}.
I0908 09:40:07.763569       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-kube-controllers-755ff8d7b5", timestamp:time.Time{wall:0xc0be8bf887ebab03, ext:45615640878, loc:(*time.Location)(0x6f12040)}}
I0908 09:40:07.763635       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/calico-kube-controllers-755ff8d7b5" (71.899µs)
I0908 09:40:08.936742       1 node_lifecycle_controller.go:1084] ReadyCondition for Node capz-4toi8r-control-plane-2z585 transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-08 09:39:26 +0000 UTC,LastTransitionTime:2022-09-08 09:38:50 +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-08 09:40:07 +0000 UTC,LastTransitionTime:2022-09-08 09:40:07 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0908 09:40:08.936857       1 node_lifecycle_controller.go:1092] Node capz-4toi8r-control-plane-2z585 ReadyCondition updated. Updating timestamp.
I0908 09:40:08.936886       1 node_lifecycle_controller.go:938] Node capz-4toi8r-control-plane-2z585 is healthy again, removing all taints
I0908 09:40:08.936906       1 node_lifecycle_controller.go:1236] Controller detected that some Nodes are Ready. Exiting master disruption mode.
I0908 09:40:09.723661       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-control-plane-2z585"
I0908 09:40:09.770674       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-control-plane-2z585"
I0908 09:40:09.951197       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-control-plane-2z585"
... skipping 36 lines ...
I0908 09:40:14.068903       1 resource_quota_monitor.go:283] quota monitor not synced: crd.projectcalico.org/v1, Resource=networkpolicies
I0908 09:40:14.169349       1 shared_informer.go:303] caches populated
I0908 09:40:14.169377       1 shared_informer.go:280] Caches are synced for resource quota
I0908 09:40:14.169386       1 resource_quota_controller.go:462] synced quota controller
I0908 09:40:14.442470       1 tokencleaner.go:166] Finished syncing secret "kube-system/bootstrap-token-5a3tta" (15.7µs)
I0908 09:40:14.552444       1 tokencleaner.go:166] Finished syncing secret "kube-system/bootstrap-token-qllkdu" (14.3µs)
W0908 09:40:15.053654       1 garbagecollector.go:752] failed to discover some groups: map[metrics.k8s.io/v1beta1:the server is currently unable to handle the request]
I0908 09:40:15.053810       1 garbagecollector.go:220] syncing garbage collector with updated resources from discovery (attempt 1): added: [crd.projectcalico.org/v1, Resource=ipamhandles crd.projectcalico.org/v1, Resource=ippools crd.projectcalico.org/v1, Resource=ipreservations crd.projectcalico.org/v1, Resource=kubecontrollersconfigurations crd.projectcalico.org/v1, Resource=networkpolicies crd.projectcalico.org/v1, Resource=networksets], removed: []
I0908 09:40:15.053824       1 garbagecollector.go:226] reset restmapper
E0908 09:40:15.065675       1 memcache.go:206] couldn't get resource list for metrics.k8s.io/v1beta1: the server is currently unable to handle the request
E0908 09:40:15.066785       1 memcache.go:104] couldn't get resource list for metrics.k8s.io/v1beta1: the server is currently unable to handle the request
I0908 09:40:15.068867       1 graph_builder.go:176] using a shared informer for resource "crd.projectcalico.org/v1, Resource=ipamhandles", kind "crd.projectcalico.org/v1, Kind=IPAMHandle"
I0908 09:40:15.069107       1 graph_builder.go:176] using a shared informer for resource "crd.projectcalico.org/v1, Resource=ipreservations", kind "crd.projectcalico.org/v1, Kind=IPReservation"
... skipping 102 lines ...
I0908 09:40:23.467214       1 endpoints_controller.go:528] Update endpoints for kube-system/kube-dns, ready: 3 not ready: 3
I0908 09:40:23.485244       1 endpointslicemirroring_controller.go:278] syncEndpoints("kube-system/kube-dns")
I0908 09:40:23.485285       1 endpointslicemirroring_controller.go:313] kube-system/kube-dns Service now has selector, cleaning up any mirrored EndpointSlices
I0908 09:40:23.485310       1 endpointslicemirroring_controller.go:275] Finished syncing EndpointSlices for "kube-system/kube-dns" Endpoints. (72.6µs)
I0908 09:40:23.487414       1 endpointslice_controller.go:319] Finished syncing service "kube-system/kube-dns" endpoint slices. (21.092076ms)
I0908 09:40:23.487467       1 endpointslice_controller.go:319] Finished syncing service "kube-system/kube-dns" endpoint slices. (26.8µs)
W0908 09:40:23.487496       1 endpointslice_controller.go:306] Error syncing endpoint slices for service "kube-system/kube-dns", retrying. Error: EndpointSlice informer cache is out of date
I0908 09:40:23.487829       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/coredns-84994b8c4" (21.92358ms)
I0908 09:40:23.488056       1 endpoints_controller.go:369] Finished syncing service "kube-system/kube-dns" endpoints. (21.032376ms)
I0908 09:40:23.488409       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="kube-system/coredns-84994b8c4"
I0908 09:40:23.488458       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/coredns" startTime="2022-09-08 09:40:23.488426953 +0000 UTC m=+82.971182480"
I0908 09:40:23.490739       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/coredns-84994b8c4", timestamp:time.Time{wall:0xc0be8bf0e25bafcb, ext:15059189650, loc:(*time.Location)(0x6f12040)}}
I0908 09:40:23.490832       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/coredns-84994b8c4" (99.4µs)
... skipping 70 lines ...
I0908 09:40:35.655893       1 httplog.go:131] "HTTP" verb="GET" URI="/healthz" latency="119.801µs" userAgent="kube-probe/1.26+" audit-ID="" srcIP="127.0.0.1:51548" resp=200
I0908 09:40:43.851650       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0908 09:40:43.880940       1 reflector.go:281] vendor/k8s.io/client-go/informers/factory.go:134: forcing resync
I0908 09:40:43.940516       1 pv_controller_base.go:612] resyncing PV controller
E0908 09:40:44.178875       1 resource_quota_controller.go:417] unable to retrieve the complete list of server APIs: metrics.k8s.io/v1beta1: the server is currently unable to handle the request
I0908 09:40:44.178931       1 resource_quota_controller.go:432] no resource updates from discovery, skipping resource quota sync
W0908 09:40:45.189937       1 garbagecollector.go:752] failed to discover some groups: map[metrics.k8s.io/v1beta1:the server is currently unable to handle the request]
I0908 09:40:45.655687       1 httplog.go:131] "HTTP" verb="GET" URI="/healthz" latency="95.101µs" userAgent="kube-probe/1.26+" audit-ID="" srcIP="127.0.0.1:59050" resp=200
I0908 09:40:47.243696       1 tokencleaner.go:166] Finished syncing secret "kube-system/bootstrap-token-qllkdu" (9.9µs)
I0908 09:40:49.569492       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-control-plane-2z585"
I0908 09:40:49.581288       1 disruption.go:494] updatePod called on pod "metrics-server-76f7667fbf-5lhhv"
I0908 09:40:49.581513       1 disruption.go:570] No PodDisruptionBudgets found for pod metrics-server-76f7667fbf-5lhhv, PodDisruptionBudget controller will avoid syncing.
I0908 09:40:49.582110       1 disruption.go:497] No matching pdb for pod "metrics-server-76f7667fbf-5lhhv"
... skipping 69 lines ...
I0908 09:41:34.356140       1 controller.go:690] Syncing backends for all LB services.
I0908 09:41:34.356164       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0908 09:41:34.356178       1 controller.go:753] Finished updateLoadBalancerHosts
I0908 09:41:34.356183       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0908 09:41:34.356190       1 controller.go:686] It took 5.87e-05 seconds to finish syncNodes
I0908 09:41:34.356357       1 topologycache.go:179] Ignoring node capz-4toi8r-control-plane-2z585 because it has an excluded label
I0908 09:41:34.356376       1 topologycache.go:183] Ignoring node capz-4toi8r-md-0-rzkvj because it is not ready: [{MemoryPressure False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +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-4toi8r-md-0-rzkvj" not found]}]
I0908 09:41:34.356446       1 topologycache.go:215] Insufficient node info for topology hints (0 zones, %!s(int64=0) CPU, true)
I0908 09:41:34.356465       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-md-0-rzkvj"
W0908 09:41:34.356483       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-4toi8r-md-0-rzkvj" does not exist
I0908 09:41:34.357114       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0be8bf27a85558b, ext:21464572342, loc:(*time.Location)(0x6f12040)}}
I0908 09:41:34.357186       1 controller_utils.go:223] Setting expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0be8c13954a2e29, ext:153839938544, loc:(*time.Location)(0x6f12040)}}
I0908 09:41:34.357202       1 daemon_controller.go:974] Nodes needing daemon pods for daemon set kube-proxy: [capz-4toi8r-md-0-rzkvj], creating 1
I0908 09:41:34.358186       1 taint_manager.go:466] "Noticed node update" node={nodeName:capz-4toi8r-md-0-rzkvj}
I0908 09:41:34.360174       1 taint_manager.go:471] "Updating known taints on node" node="capz-4toi8r-md-0-rzkvj" taints=[]
I0908 09:41:34.358465       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-node", timestamp:time.Time{wall:0xc0be8c0033765dc0, ext:76346150891, loc:(*time.Location)(0x6f12040)}}
... skipping 121 lines ...
I0908 09:41:38.290112       1 controller.go:690] Syncing backends for all LB services.
I0908 09:41:38.290120       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0908 09:41:38.290190       1 controller.go:753] Finished updateLoadBalancerHosts
I0908 09:41:38.290198       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0908 09:41:38.290219       1 controller.go:686] It took 0.000108501 seconds to finish syncNodes
I0908 09:41:38.290283       1 topologycache.go:179] Ignoring node capz-4toi8r-control-plane-2z585 because it has an excluded label
I0908 09:41:38.290300       1 topologycache.go:183] Ignoring node capz-4toi8r-md-0-rzkvj because it is not ready: [{MemoryPressure False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-08 09:41:34 +0000 UTC 2022-09-08 09:41:34 +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-4toi8r-md-0-rzkvj" not found]}]
I0908 09:41:38.290353       1 topologycache.go:183] Ignoring node capz-4toi8r-md-0-2tfwf because it is not ready: [{MemoryPressure False 2022-09-08 09:41:38 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-08 09:41:38 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-08 09:41:38 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-08 09:41:38 +0000 UTC 2022-09-08 09:41:38 +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]}]
I0908 09:41:38.290463       1 topologycache.go:215] Insufficient node info for topology hints (0 zones, %!s(int64=0) CPU, true)
I0908 09:41:38.290480       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-md-0-2tfwf"
W0908 09:41:38.290544       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-4toi8r-md-0-2tfwf" does not exist
I0908 09:41:38.293458       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0be8c1399054ad8, ext:153902532767, loc:(*time.Location)(0x6f12040)}}
I0908 09:41:38.293661       1 controller_utils.go:223] Setting expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0be8c149180d197, ext:157776410562, loc:(*time.Location)(0x6f12040)}}
I0908 09:41:38.293684       1 daemon_controller.go:974] Nodes needing daemon pods for daemon set kube-proxy: [capz-4toi8r-md-0-2tfwf], creating 1
I0908 09:41:38.301312       1 controller_utils.go:581] Controller kube-proxy created pod kube-proxy-xvwd8
I0908 09:41:38.301383       1 daemon_controller.go:1036] Pods to delete for daemon set kube-proxy: [], deleting 0
I0908 09:41:38.301401       1 controller_utils.go:195] Controller still waiting on expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0be8c149180d197, ext:157776410562, loc:(*time.Location)(0x6f12040)}}
... skipping 393 lines ...
I0908 09:42:04.358153       1 azure_vmss.go:370] Can not extract scale set name from providerID (azure:///subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-4toi8r/providers/Microsoft.Compute/virtualMachines/capz-4toi8r-md-0-2tfwf), assuming it is managed by availability set: not a vmss instance
I0908 09:42:04.358228       1 azure_vmss.go:370] Can not extract scale set name from providerID (azure:///subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-4toi8r/providers/Microsoft.Compute/virtualMachines/capz-4toi8r-md-0-2tfwf), assuming it is managed by availability set: not a vmss instance
I0908 09:42:04.358256       1 azure_instances.go:240] InstanceShutdownByProviderID gets power status "running" for node "capz-4toi8r-md-0-2tfwf"
I0908 09:42:04.358268       1 azure_instances.go:251] InstanceShutdownByProviderID gets provisioning state "Updating" for node "capz-4toi8r-md-0-2tfwf"
I0908 09:42:05.123217       1 controller_utils.go:205] "Added taint to node" taint=[] node="capz-4toi8r-md-0-rzkvj"
I0908 09:42:05.123865       1 topologycache.go:179] Ignoring node capz-4toi8r-control-plane-2z585 because it has an excluded label
I0908 09:42:05.124535       1 topologycache.go:183] Ignoring node capz-4toi8r-md-0-2tfwf because it is not ready: [{MemoryPressure False 2022-09-08 09:41:48 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletHasSufficientMemory kubelet has sufficient memory available} {DiskPressure False 2022-09-08 09:41:48 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletHasNoDiskPressure kubelet has no disk pressure} {PIDPressure False 2022-09-08 09:41:48 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletHasSufficientPID kubelet has sufficient PID available} {Ready False 2022-09-08 09:41:48 +0000 UTC 2022-09-08 09:41:38 +0000 UTC KubeletNotReady container runtime network not ready: NetworkReady=false reason:NetworkPluginNotReady message:Network plugin returns error: cni plugin not initialized}]
I0908 09:42:05.124751       1 topologycache.go:215] Insufficient node info for topology hints (1 zones, %!s(int64=2000) CPU, true)
I0908 09:42:05.123880       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-md-0-rzkvj"
I0908 09:42:05.124104       1 controller.go:690] Syncing backends for all LB services.
I0908 09:42:05.125158       1 controller.go:728] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0908 09:42:05.125286       1 controller.go:753] Finished updateLoadBalancerHosts
I0908 09:42:05.125428       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
... skipping 9 lines ...
I0908 09:42:08.874535       1 controller.go:694] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0908 09:42:08.874542       1 controller.go:686] It took 4.16e-05 seconds to finish syncNodes
I0908 09:42:08.874580       1 topologycache.go:179] Ignoring node capz-4toi8r-control-plane-2z585 because it has an excluded label
I0908 09:42:08.874611       1 topologycache.go:215] Insufficient node info for topology hints (1 zones, %!s(int64=4000) CPU, true)
I0908 09:42:08.883539       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-md-0-2tfwf"
I0908 09:42:08.884879       1 controller_utils.go:217] "Made sure that node has no taint" node="capz-4toi8r-md-0-2tfwf" taint=[&Taint{Key:node.kubernetes.io/not-ready,Value:,Effect:NoSchedule,TimeAdded:<nil>,}]
I0908 09:42:08.952724       1 node_lifecycle_controller.go:1084] ReadyCondition for Node capz-4toi8r-md-0-rzkvj transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-08 09:41:54 +0000 UTC,LastTransitionTime:2022-09-08 09:41:34 +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-08 09:42:05 +0000 UTC,LastTransitionTime:2022-09-08 09:42:05 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0908 09:42:08.952838       1 node_lifecycle_controller.go:1092] Node capz-4toi8r-md-0-rzkvj ReadyCondition updated. Updating timestamp.
I0908 09:42:08.961590       1 taint_manager.go:466] "Noticed node update" node={nodeName:capz-4toi8r-md-0-rzkvj}
I0908 09:42:08.961825       1 taint_manager.go:471] "Updating known taints on node" node="capz-4toi8r-md-0-rzkvj" taints=[]
I0908 09:42:08.961851       1 taint_manager.go:492] "All taints were removed from the node. Cancelling all evictions..." node="capz-4toi8r-md-0-rzkvj"
I0908 09:42:08.961804       1 node_lifecycle_controller.go:938] Node capz-4toi8r-md-0-rzkvj is healthy again, removing all taints
I0908 09:42:08.961920       1 node_lifecycle_controller.go:1084] ReadyCondition for Node capz-4toi8r-md-0-2tfwf transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-08 09:41:48 +0000 UTC,LastTransitionTime:2022-09-08 09:41:38 +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-08 09:42:08 +0000 UTC,LastTransitionTime:2022-09-08 09:42:08 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0908 09:42:08.961973       1 node_lifecycle_controller.go:1092] Node capz-4toi8r-md-0-2tfwf ReadyCondition updated. Updating timestamp.
I0908 09:42:08.962219       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-md-0-rzkvj"
I0908 09:42:08.973619       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-4toi8r-md-0-2tfwf"
I0908 09:42:08.974203       1 taint_manager.go:466] "Noticed node update" node={nodeName:capz-4toi8r-md-0-2tfwf}
I0908 09:42:08.974223       1 taint_manager.go:471] "Updating known taints on node" node="capz-4toi8r-md-0-2tfwf" taints=[]
I0908 09:42:08.974240       1 taint_manager.go:492] "All taints were removed from the node. Cancelling all evictions..." node="capz-4toi8r-md-0-2tfwf"
... skipping 53 lines ...
I0908 09:42:16.826025       1 deployment_util.go:775] Deployment "csi-azurefile-controller" timed out (false) [last progress check: 2022-09-08 09:42:16.807357907 +0000 UTC m=+196.290113534 - now: 2022-09-08 09:42:16.826014645 +0000 UTC m=+196.308770272]
I0908 09:42:16.832244       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="kube-system/csi-azurefile-controller-7847f46f86-ltdn4" podUID=12a518bd-86b2-4ad8-8aed-97e5ef9cc183
I0908 09:42:16.832536       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.832561       1 disruption.go:479] addPod called on pod "csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.832822       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-azurefile-controller-7847f46f86-ltdn4, PodDisruptionBudget controller will avoid syncing.
I0908 09:42:16.832903       1 disruption.go:482] No matching pdb for pod "csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.832407       1 replica_set.go:394] Pod csi-azurefile-controller-7847f46f86-ltdn4 created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"csi-azurefile-controller-7847f46f86-ltdn4", GenerateName:"csi-azurefile-controller-7847f46f86-", Namespace:"kube-system", SelfLink:"", UID:"12a518bd-86b2-4ad8-8aed-97e5ef9cc183", ResourceVersion:"987", Generation:0, CreationTimestamp:time.Date(2022, time.September, 8, 9, 42, 16, 0, time.Local), DeletionTimestamp:<nil>, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"app":"csi-azurefile-controller", "pod-template-hash":"7847f46f86"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"csi-azurefile-controller-7847f46f86", UID:"c4e6dc8f-bbd0-4649-b79e-4b51ab984aba", Controller:(*bool)(0xc002f09ea7), BlockOwnerDeletion:(*bool)(0xc002f09ea8)}}, Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:time.Date(2022, time.September, 8, 9, 42, 16, 0, time.Local), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc002f0cf90), Subresource:""}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"socket-dir", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(0xc002f0cfa8), 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)(0xc002f0cfc0), 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-qfqfj", 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)(0xc00269b140), 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{"-v=2", "--csi-address=$(ADDRESS)", "--leader-election", "--leader-election-namespace=kube-system", "--timeout=300s", "--extra-create-metadata=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-qfqfj", 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=120s", "--leader-election", "--leader-election-namespace=kube-system"}, 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-qfqfj", 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{"-v=2", "-csi-address=$(ADDRESS)", "--leader-election", "--leader-election-namespace=kube-system"}, 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-qfqfj", 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=120s"}, 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-qfqfj", 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=29612", "--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-qfqfj", 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:"azurefile", Image:"mcr.microsoft.com/k8s/csi/azurefile-csi:latest", Command:[]string(nil), Args:[]string{"--v=5", "--endpoint=$(CSI_ENDPOINT)", "--metrics-address=0.0.0.0:29614", "--user-agent-suffix=OSS-kubectl"}, WorkingDir:"", Ports:[]v1.ContainerPort{v1.ContainerPort{Name:"healthz", HostPort:29612, ContainerPort:29612, Protocol:"TCP", HostIP:""}, v1.ContainerPort{Name:"metrics", HostPort:29614, ContainerPort:29614, Protocol:"TCP", HostIP:""}}, EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"AZURE_CREDENTIAL_FILE", Value:"", ValueFrom:(*v1.EnvVarSource)(0xc00269b260)}, 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:209715200, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"", 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-qfqfj", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(0xc0029c4040), 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)(0xc00253e270), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string{"kubernetes.io/os":"linux"}, ServiceAccountName:"csi-azurefile-controller-sa", DeprecatedServiceAccount:"csi-azurefile-controller-sa", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:true, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc000164cb0), 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)(0xc00253e300)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc00253e320)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc00253e328), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc00253e32c), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc00269d080), 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)}}.
I0908 09:42:16.833102       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/csi-azurefile-controller-7847f46f86", timestamp:time.Time{wall:0xc0be8c1e303dfe7b, ext:196292124738, loc:(*time.Location)(0x6f12040)}}
I0908 09:42:16.840196       1 replica_set.go:457] Pod csi-azurefile-controller-7847f46f86-ltdn4 updated, objectMeta {Name:csi-azurefile-controller-7847f46f86-ltdn4 GenerateName:csi-azurefile-controller-7847f46f86- Namespace:kube-system SelfLink: UID:12a518bd-86b2-4ad8-8aed-97e5ef9cc183 ResourceVersion:987 Generation:0 CreationTimestamp:2022-09-08 09:42:16 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-azurefile-controller pod-template-hash:7847f46f86] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-azurefile-controller-7847f46f86 UID:c4e6dc8f-bbd0-4649-b79e-4b51ab984aba Controller:0xc002f09ea7 BlockOwnerDeletion:0xc002f09ea8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:42:16 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"c4e6dc8f-bbd0-4649-b79e-4b51ab984aba\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"azurefile\"}":{".":{},"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\":29612,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":29614,\"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-azurefile-controller-7847f46f86-ltdn4 GenerateName:csi-azurefile-controller-7847f46f86- Namespace:kube-system SelfLink: UID:12a518bd-86b2-4ad8-8aed-97e5ef9cc183 ResourceVersion:988 Generation:0 CreationTimestamp:2022-09-08 09:42:16 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-azurefile-controller pod-template-hash:7847f46f86] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-azurefile-controller-7847f46f86 UID:c4e6dc8f-bbd0-4649-b79e-4b51ab984aba Controller:0xc00253fc07 BlockOwnerDeletion:0xc00253fc08}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:42:16 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"c4e6dc8f-bbd0-4649-b79e-4b51ab984aba\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"azurefile\"}":{".":{},"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\":29612,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":29614,\"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:}]}.
I0908 09:42:16.840740       1 disruption.go:494] updatePod called on pod "csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.841122       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-azurefile-controller-7847f46f86-ltdn4, PodDisruptionBudget controller will avoid syncing.
I0908 09:42:16.841252       1 disruption.go:497] No matching pdb for pod "csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.840835       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.844646       1 controller_utils.go:581] Controller csi-azurefile-controller-7847f46f86 created pod csi-azurefile-controller-7847f46f86-ltdn4
I0908 09:42:16.845570       1 event.go:294] "Event occurred" object="kube-system/csi-azurefile-controller-7847f46f86" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: csi-azurefile-controller-7847f46f86-ltdn4"
I0908 09:42:16.856259       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-azurefile-controller" duration="65.050933ms"
I0908 09:42:16.856379       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/csi-azurefile-controller" err="Operation cannot be fulfilled on deployments.apps \"csi-azurefile-controller\": the object has been modified; please apply your changes to the latest version and try again"
I0908 09:42:16.856472       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-azurefile-controller" startTime="2022-09-08 09:42:16.856454307 +0000 UTC m=+196.339209834"
I0908 09:42:16.857986       1 deployment_util.go:775] Deployment "csi-azurefile-controller" timed out (false) [last progress check: 2022-09-08 09:42:16 +0000 UTC - now: 2022-09-08 09:42:16.857976011 +0000 UTC m=+196.340731538]
I0908 09:42:16.869191       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azurefile-controller-7847f46f86-vc6cm"
I0908 09:42:16.869657       1 controller_utils.go:581] Controller csi-azurefile-controller-7847f46f86 created pod csi-azurefile-controller-7847f46f86-vc6cm
I0908 09:42:16.869827       1 replica_set_utils.go:59] Updating status for : kube-system/csi-azurefile-controller-7847f46f86, replicas 0->0 (need 2), fullyLabeledReplicas 0->0, readyReplicas 0->0, availableReplicas 0->0, sequence No: 0->1
I0908 09:42:16.870403       1 event.go:294] "Event occurred" object="kube-system/csi-azurefile-controller-7847f46f86" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: csi-azurefile-controller-7847f46f86-vc6cm"
I0908 09:42:16.870484       1 disruption.go:479] addPod called on pod "csi-azurefile-controller-7847f46f86-vc6cm"
I0908 09:42:16.870567       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-azurefile-controller-7847f46f86-vc6cm, PodDisruptionBudget controller will avoid syncing.
I0908 09:42:16.870580       1 disruption.go:482] No matching pdb for pod "csi-azurefile-controller-7847f46f86-vc6cm"
I0908 09:42:16.870652       1 pvc_protection_controller.go:380] "Enqueuing PVCs for Pod" pod="kube-system/csi-azurefile-controller-7847f46f86-vc6cm" podUID=21b57d22-e845-4869-9257-3069a0a51a73
I0908 09:42:16.870685       1 replica_set.go:394] Pod csi-azurefile-controller-7847f46f86-vc6cm created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"csi-azurefile-controller-7847f46f86-vc6cm", GenerateName:"csi-azurefile-controller-7847f46f86-", Namespace:"kube-system", SelfLink:"", UID:"21b57d22-e845-4869-9257-3069a0a51a73", ResourceVersion:"991", Generation:0, CreationTimestamp:time.Date(2022, time.September, 8, 9, 42, 16, 0, time.Local), DeletionTimestamp:<nil>, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"app":"csi-azurefile-controller", "pod-template-hash":"7847f46f86"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"csi-azurefile-controller-7847f46f86", UID:"c4e6dc8f-bbd0-4649-b79e-4b51ab984aba", Controller:(*bool)(0xc001fe3dd7), BlockOwnerDeletion:(*bool)(0xc001fe3dd8)}}, Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:time.Date(2022, time.September, 8, 9, 42, 16, 0, time.Local), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc002a66ea0), Subresource:""}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"socket-dir", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(0xc002a66eb8), 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)(0xc002a66ed0), 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-f8qlk", 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)(0xc0029520c0), 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{"-v=2", "--csi-address=$(ADDRESS)", "--leader-election", "--leader-election-namespace=kube-system", "--timeout=300s", "--extra-create-metadata=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-f8qlk", 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=120s", "--leader-election", "--leader-election-namespace=kube-system"}, 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-f8qlk", 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{"-v=2", "-csi-address=$(ADDRESS)", "--leader-election", "--leader-election-namespace=kube-system"}, 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-f8qlk", 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=120s"}, 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-f8qlk", 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=29612", "--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-f8qlk", 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:"azurefile", Image:"mcr.microsoft.com/k8s/csi/azurefile-csi:latest", Command:[]string(nil), Args:[]string{"--v=5", "--endpoint=$(CSI_ENDPOINT)", "--metrics-address=0.0.0.0:29614", "--user-agent-suffix=OSS-kubectl"}, WorkingDir:"", Ports:[]v1.ContainerPort{v1.ContainerPort{Name:"healthz", HostPort:29612, ContainerPort:29612, Protocol:"TCP", HostIP:""}, v1.ContainerPort{Name:"metrics", HostPort:29614, ContainerPort:29614, Protocol:"TCP", HostIP:""}}, EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar{v1.EnvVar{Name:"AZURE_CREDENTIAL_FILE", Value:"", ValueFrom:(*v1.EnvVarSource)(0xc0029521e0)}, 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:209715200, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"", 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-f8qlk", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(0xc001fdb2c0), 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)(0xc00273c1c0), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string{"kubernetes.io/os":"linux"}, ServiceAccountName:"csi-azurefile-controller-sa", DeprecatedServiceAccount:"csi-azurefile-controller-sa", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:true, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc00052d570), 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)(0xc00273c230)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc00273c260)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc00273c268), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc00273c26c), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc0002b8710), 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)}}.
I0908 09:42:16.871847       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/csi-azurefile-controller-7847f46f86", timestamp:time.Time{wall:0xc0be8c1e303dfe7b, ext:196292124738, loc:(*time.Location)(0x6f12040)}}
I0908 09:42:16.878294       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-azurefile-controller" duration="21.805845ms"
I0908 09:42:16.878384       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-azurefile-controller" startTime="2022-09-08 09:42:16.878328052 +0000 UTC m=+196.361083579"
I0908 09:42:16.879189       1 deployment_controller.go:183] "Updating deployment" deployment="kube-system/csi-azurefile-controller"
I0908 09:42:16.880463       1 deployment_util.go:775] Deployment "csi-azurefile-controller" timed out (false) [last progress check: 2022-09-08 09:42:16 +0000 UTC - now: 2022-09-08 09:42:16.880454357 +0000 UTC m=+196.363209884]
I0908 09:42:16.892057       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="kube-system/csi-azurefile-controller-7847f46f86"
... skipping 7 lines ...
I0908 09:42:16.892869       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-azurefile-controller-7847f46f86-vc6cm"
I0908 09:42:16.892912       1 replica_set.go:457] Pod csi-azurefile-controller-7847f46f86-vc6cm updated, objectMeta {Name:csi-azurefile-controller-7847f46f86-vc6cm GenerateName:csi-azurefile-controller-7847f46f86- Namespace:kube-system SelfLink: UID:21b57d22-e845-4869-9257-3069a0a51a73 ResourceVersion:991 Generation:0 CreationTimestamp:2022-09-08 09:42:16 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-azurefile-controller pod-template-hash:7847f46f86] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-azurefile-controller-7847f46f86 UID:c4e6dc8f-bbd0-4649-b79e-4b51ab984aba Controller:0xc001fe3dd7 BlockOwnerDeletion:0xc001fe3dd8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:42:16 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"c4e6dc8f-bbd0-4649-b79e-4b51ab984aba\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"azurefile\"}":{".":{},"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\":29612,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":29614,\"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-azurefile-controller-7847f46f86-vc6cm GenerateName:csi-azurefile-controller-7847f46f86- Namespace:kube-system SelfLink: UID:21b57d22-e845-4869-9257-3069a0a51a73 ResourceVersion:996 Generation:0 CreationTimestamp:2022-09-08 09:42:16 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:csi-azurefile-controller pod-template-hash:7847f46f86] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:csi-azurefile-controller-7847f46f86 UID:c4e6dc8f-bbd0-4649-b79e-4b51ab984aba Controller:0xc0025d5707 BlockOwnerDeletion:0xc0025d5708}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:42:16 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"c4e6dc8f-bbd0-4649-b79e-4b51ab984aba\"}":{}}},"f:spec":{"f:containers":{"k:{\"name\":\"azurefile\"}":{".":{},"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\":29612,\"protocol\":\"TCP\"}":{".":{},"f:containerPort":{},"f:hostPort":{},"f:name":{},"f:protocol":{}},"k:{\"containerPort\":29614,\"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:}]}.
I0908 09:42:16.893715       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/csi-azurefile-controller-7847f46f86" (84.798574ms)
I0908 09:42:16.897056       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/csi-azurefile-controller-7847f46f86", timestamp:time.Time{wall:0xc0be8c1e303dfe7b, ext:196292124738, loc:(*time.Location)(0x6f12040)}}
I0908 09:42:16.897241       1 replica_set_utils.go:59] Updating status for : kube-system/csi-azurefile-controller-7847f46f86, replicas 0->2 (need 2), fullyLabeledReplicas 0->2, readyReplicas 0->0, availableReplicas 0->0, sequence No: 1->1
I0908 09:42:16.907704       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-azurefile-controller" duration="29.33736ms"
I0908 09:42:16.907745       1 deployment_controller.go:497] "Error syncing deployment" deployment="kube-system/csi-azurefile-controller" err="Operation cannot be fulfilled on deployments.apps \"csi-azurefile-controller\": the object has been modified; please apply your changes to the latest version and try again"
I0908 09:42:16.907826       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-azurefile-controller" startTime="2022-09-08 09:42:16.907810612 +0000 UTC m=+196.390566139"
I0908 09:42:16.909426       1 deployment_util.go:775] Deployment "csi-azurefile-controller" timed out (false) [last progress check: 2022-09-08 09:42:16 +0000 UTC - now: 2022-09-08 09:42:16.909416616 +0000 UTC m=+196.392172143]
I0908 09:42:16.910139       1 progress.go:195] Queueing up deployment "csi-azurefile-controller" for a progress check after 599s
I0908 09:42:16.910200       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-azurefile-controller" duration="2.357205ms"
I0908 09:42:16.914317       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-azurefile-controller" startTime="2022-09-08 09:42:16.914296626 +0000 UTC m=+196.397052253"
I0908 09:42:16.915890       1 deployment_util.go:775] Deployment "csi-azurefile-controller" timed out (false) [last progress check: 2022-09-08 09:42:16 +0000 UTC - now: 2022-09-08 09:42:16.915881129 +0000 UTC m=+196.398636656]
... skipping 207 lines ...
I0908 09:42:24.832251       1 replica_set.go:457] Pod csi-snapshot-controller-84ccd6c756-2kf88 updated, objectMeta {Name:csi-snapshot-controller-84ccd6c756-2kf88 GenerateName:csi-snapshot-controller-84ccd6c756- Namespace:kube-system SelfLink: UID:0c210191-b5e4-4a0d-ad7a-6da62102c78d ResourceVersion:1102 Generation:0 CreationTimestamp:2022-09-08 09:42:24 +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:f40da3f2-ef34-4da3-b63f-21599b9cecd6 Controller:0xc001d2ab77 BlockOwnerDeletion:0xc001d2ab78}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:42:24 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"f40da3f2-ef34-4da3-b63f-21599b9cecd6\"}":{}}},"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-2kf88 GenerateName:csi-snapshot-controller-84ccd6c756- Namespace:kube-system SelfLink: UID:0c210191-b5e4-4a0d-ad7a-6da62102c78d ResourceVersion:1104 Generation:0 CreationTimestamp:2022-09-08 09:42:24 +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:f40da3f2-ef34-4da3-b63f-21599b9cecd6 Controller:0xc001d6317e BlockOwnerDeletion:0xc001d6317f}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:42:24 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"f40da3f2-ef34-4da3-b63f-21599b9cecd6\"}":{}}},"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:}]}.
I0908 09:42:24.832462       1 taint_manager.go:431] "Noticed pod update" pod="kube-system/csi-snapshot-controller-84ccd6c756-2kf88"
I0908 09:42:24.832503       1 disruption.go:494] updatePod called on pod "csi-snapshot-controller-84ccd6c756-2kf88"
I0908 09:42:24.832534       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-snapshot-controller-84ccd6c756-2kf88, PodDisruptionBudget controller will avoid syncing.
I0908 09:42:24.832540       1 disruption.go:497] No matching pdb for pod "csi-snapshot-controller-84ccd6c756-2kf88"
I0908 09:42:24.835565       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="26.823353ms"
I0908 09:42:24.835598       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"
I0908 09:42:24.835630       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-snapshot-controller" startTime="2022-09-08 09:42:24.835615345 +0000 UTC m=+204.318370872"
I0908 09:42:24.836109       1 deployment_util.go:775] Deployment "csi-snapshot-controller" timed out (false) [last progress check: 2022-09-08 09:42:24 +0000 UTC - now: 2022-09-08 09:42:24.836100346 +0000 UTC m=+204.318855973]
I0908 09:42:24.846910       1 controller_utils.go:581] Controller csi-snapshot-controller-84ccd6c756 created pod csi-snapshot-controller-84ccd6c756-ndvwx
I0908 09:42:24.846972       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
I0908 09:42:24.847258       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="11.626323ms"
I0908 09:42:24.847293       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-snapshot-controller" startTime="2022-09-08 09:42:24.847276868 +0000 UTC m=+204.330032395"
... skipping 18 lines ...
I0908 09:42:24.860706       1 disruption.go:570] No PodDisruptionBudgets found for pod csi-snapshot-controller-84ccd6c756-2kf88, PodDisruptionBudget controller will avoid syncing.
I0908 09:42:24.860716       1 disruption.go:497] No matching pdb for pod "csi-snapshot-controller-84ccd6c756-2kf88"
I0908 09:42:24.860872       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/csi-snapshot-controller-84ccd6c756" (48.560795ms)
I0908 09:42:24.860892       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/csi-snapshot-controller-84ccd6c756", timestamp:time.Time{wall:0xc0be8c20306c02e7, ext:204295140626, loc:(*time.Location)(0x6f12040)}}
I0908 09:42:24.860976       1 replica_set_utils.go:59] Updating status for : kube-system/csi-snapshot-controller-84ccd6c756, replicas 0->2 (need 2), fullyLabeledReplicas 0->2, readyReplicas 0->0, availableReplicas 0->0, sequence No: 1->1
I0908 09:42:24.868552       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="21.261841ms"
I0908 09:42:24.868584       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"
I0908 09:42:24.868616       1 deployment_controller.go:583] "Started syncing deployment" deployment="kube-system/csi-snapshot-controller" startTime="2022-09-08 09:42:24.868600809 +0000 UTC m=+204.351356336"
I0908 09:42:24.869003       1 deployment_util.go:775] Deployment "csi-snapshot-controller" timed out (false) [last progress check: 2022-09-08 09:42:24 +0000 UTC - now: 2022-09-08 09:42:24.86897591 +0000 UTC m=+204.351731537]
I0908 09:42:24.869033       1 progress.go:195] Queueing up deployment "csi-snapshot-controller" for a progress check after 599s
I0908 09:42:24.869053       1 deployment_controller.go:585] "Finished syncing deployment" deployment="kube-system/csi-snapshot-controller" duration="443.101µs"
I0908 09:42:24.870903       1 replica_set.go:667] Finished syncing ReplicaSet "kube-system/csi-snapshot-controller-84ccd6c756" (10.01232ms)
I0908 09:42:24.871038       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="kube-system/csi-snapshot-controller-84ccd6c756"
... skipping 1496 lines ...
I0908 09:48:05.998269       1 replica_set_utils.go:59] Updating status for : azurefile-5356/azurefile-volume-tester-thjpt-58588b87b7, replicas 0->1 (need 1), fullyLabeledReplicas 0->1, readyReplicas 0->0, availableReplicas 0->0, sequence No: 1->1
I0908 09:48:06.003423       1 deployment_controller.go:288] "ReplicaSet updated" replicaSet="azurefile-5356/azurefile-volume-tester-thjpt-58588b87b7"
I0908 09:48:06.003474       1 replica_set.go:667] Finished syncing ReplicaSet "azurefile-5356/azurefile-volume-tester-thjpt-58588b87b7" (5.425008ms)
I0908 09:48:06.003753       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"azurefile-5356/azurefile-volume-tester-thjpt-58588b87b7", timestamp:time.Time{wall:0xc0be8c757a659324, ext:545462490859, loc:(*time.Location)(0x6f12040)}}
I0908 09:48:06.003959       1 replica_set.go:667] Finished syncing ReplicaSet "azurefile-5356/azurefile-volume-tester-thjpt-58588b87b7" (202µs)
I0908 09:48:06.003560       1 deployment_controller.go:585] "Finished syncing deployment" deployment="azurefile-5356/azurefile-volume-tester-thjpt" duration="27.56934ms"
I0908 09:48:06.004301       1 deployment_controller.go:497] "Error syncing deployment" deployment="azurefile-5356/azurefile-volume-tester-thjpt" err="Operation cannot be fulfilled on deployments.apps \"azurefile-volume-tester-thjpt\": the object has been modified; please apply your changes to the latest version and try again"
I0908 09:48:06.004482       1 deployment_controller.go:583] "Started syncing deployment" deployment="azurefile-5356/azurefile-volume-tester-thjpt" startTime="2022-09-08 09:48:06.004462468 +0000 UTC m=+545.487217995"
I0908 09:48:06.010637       1 disruption.go:494] updatePod called on pod "azurefile-volume-tester-thjpt-58588b87b7-hwjpj"
I0908 09:48:06.010667       1 disruption.go:570] No PodDisruptionBudgets found for pod azurefile-volume-tester-thjpt-58588b87b7-hwjpj, PodDisruptionBudget controller will avoid syncing.
I0908 09:48:06.010673       1 disruption.go:497] No matching pdb for pod "azurefile-volume-tester-thjpt-58588b87b7-hwjpj"
I0908 09:48:06.011239       1 replica_set.go:457] Pod azurefile-volume-tester-thjpt-58588b87b7-hwjpj updated, objectMeta {Name:azurefile-volume-tester-thjpt-58588b87b7-hwjpj GenerateName:azurefile-volume-tester-thjpt-58588b87b7- Namespace:azurefile-5356 SelfLink: UID:53cfbb5c-c3c2-45c3-abc8-bce24d77efd2 ResourceVersion:2250 Generation:0 CreationTimestamp:2022-09-08 09:48:05 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:azurefile-volume-tester-5018949295715050020 pod-template-hash:58588b87b7] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:azurefile-volume-tester-thjpt-58588b87b7 UID:2f5a9305-a590-4a6f-ab24-a921cbd87a66 Controller:0xc001d2afb7 BlockOwnerDeletion:0xc001d2afb8}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:48:05 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"2f5a9305-a590-4a6f-ab24-a921cbd87a66\"}":{}}},"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:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:terminationGracePeriodSeconds":{},"f:volumes":{".":{},"k:{\"name\":\"test-volume-1\"}":{".":{},"f:name":{},"f:persistentVolumeClaim":{".":{},"f:claimName":{}}}}}} Subresource:}]} -> {Name:azurefile-volume-tester-thjpt-58588b87b7-hwjpj GenerateName:azurefile-volume-tester-thjpt-58588b87b7- Namespace:azurefile-5356 SelfLink: UID:53cfbb5c-c3c2-45c3-abc8-bce24d77efd2 ResourceVersion:2255 Generation:0 CreationTimestamp:2022-09-08 09:48:05 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[app:azurefile-volume-tester-5018949295715050020 pod-template-hash:58588b87b7] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:azurefile-volume-tester-thjpt-58588b87b7 UID:2f5a9305-a590-4a6f-ab24-a921cbd87a66 Controller:0xc001d2bb17 BlockOwnerDeletion:0xc001d2bb18}] Finalizers:[] ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-08 09:48:05 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"2f5a9305-a590-4a6f-ab24-a921cbd87a66\"}":{}}},"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: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-08 09:48:06 +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}]}.
I0908 09:48:06.011331       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"azurefile-5356/azurefile-volume-tester-thjpt-58588b87b7", timestamp:time.Time{wall:0xc0be8c757a659324, ext:545462490859, loc:(*time.Location)(0x6f12040)}}
... skipping 1319 lines ...
I0908 09:51:21.193335       1 reflector.go:559] vendor/k8s.io/client-go/informers/factory.go:134: Watch close - *v1.ValidatingWebhookConfiguration total 6 items received
2022/09/08 09:51:21 ===================================================

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

Ran 6 of 34 Specs in 362.329 seconds
SUCCESS! -- 6 Passed | 0 Failed | 0 Pending | 28 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-vmbmp, container manager
STEP: Dumping workload cluster default/capz-4toi8r logs
Sep  8 09:52:57.710: INFO: Collecting logs for Linux node capz-4toi8r-control-plane-2z585 in cluster capz-4toi8r in namespace default

Sep  8 09:53:57.711: INFO: Collecting boot logs for AzureMachine capz-4toi8r-control-plane-2z585

Failed to get logs for machine capz-4toi8r-control-plane-ntn6r, cluster default/capz-4toi8r: open /etc/azure-ssh/azure-ssh: no such file or directory
Sep  8 09:53:59.202: INFO: Collecting logs for Linux node capz-4toi8r-md-0-rzkvj in cluster capz-4toi8r in namespace default

Sep  8 09:54:59.205: INFO: Collecting boot logs for AzureMachine capz-4toi8r-md-0-rzkvj

Failed to get logs for machine capz-4toi8r-md-0-68dcdc7bdc-4zd4h, cluster default/capz-4toi8r: open /etc/azure-ssh/azure-ssh: no such file or directory
Sep  8 09:54:59.675: INFO: Collecting logs for Linux node capz-4toi8r-md-0-2tfwf in cluster capz-4toi8r in namespace default

Sep  8 09:55:59.679: INFO: Collecting boot logs for AzureMachine capz-4toi8r-md-0-2tfwf

Failed to get logs for machine capz-4toi8r-md-0-68dcdc7bdc-lj5sk, cluster default/capz-4toi8r: open /etc/azure-ssh/azure-ssh: no such file or directory
STEP: Dumping workload cluster default/capz-4toi8r kube-system pod logs
STEP: Creating log watcher for controller kube-system/csi-azurefile-controller-7847f46f86-ltdn4, container csi-provisioner
STEP: Collecting events for Pod kube-system/csi-azurefile-controller-7847f46f86-ltdn4
STEP: Creating log watcher for controller kube-system/csi-azurefile-controller-7847f46f86-vc6cm, container csi-snapshotter
STEP: Creating log watcher for controller kube-system/csi-azurefile-controller-7847f46f86-ltdn4, container csi-attacher
STEP: Creating log watcher for controller kube-system/csi-azurefile-controller-7847f46f86-vc6cm, container csi-provisioner
... skipping 44 lines ...
STEP: Creating log watcher for controller kube-system/kube-scheduler-capz-4toi8r-control-plane-2z585, container kube-scheduler
STEP: Collecting events for Pod kube-system/calico-node-fc2vb
STEP: Collecting events for Pod kube-system/csi-azurefile-node-qfdrs
STEP: Collecting events for Pod kube-system/kube-scheduler-capz-4toi8r-control-plane-2z585
STEP: Creating log watcher for controller kube-system/kube-proxy-sfwjk, container kube-proxy
STEP: Creating log watcher for controller kube-system/kube-controller-manager-capz-4toi8r-control-plane-2z585, container kube-controller-manager
STEP: failed to find events of Pod "kube-scheduler-capz-4toi8r-control-plane-2z585"
STEP: Collecting events for Pod kube-system/kube-controller-manager-capz-4toi8r-control-plane-2z585
STEP: Creating log watcher for controller kube-system/csi-azurefile-controller-7847f46f86-vc6cm, container liveness-probe
STEP: Creating log watcher for controller kube-system/csi-snapshot-controller-84ccd6c756-ndvwx, container csi-snapshot-controller
STEP: failed to find events of Pod "kube-controller-manager-capz-4toi8r-control-plane-2z585"
STEP: Collecting events for Pod kube-system/kube-proxy-sfwjk
STEP: Collecting events for Pod kube-system/etcd-capz-4toi8r-control-plane-2z585
STEP: failed to find events of Pod "etcd-capz-4toi8r-control-plane-2z585"
STEP: Fetching activity logs took 1.785200066s
================ REDACTING LOGS ================
All sensitive variables are redacted
cluster.cluster.x-k8s.io "capz-4toi8r" deleted
/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/hack/tools/bin/kind-v0.14.0 delete cluster --name=capz || true
Deleting cluster "capz" ...
... skipping 12 lines ...