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

No Test Failures!


Show 6 Passed Tests

Show 28 Skipped Tests

Error lines from build-log.txt

... skipping 627 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 137 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-ph31wc-kubeconfig; do sleep 1; done"
capz-ph31wc-kubeconfig                 cluster.x-k8s.io/secret   1      0s
# Get kubeconfig and store it locally.
/home/prow/go/src/sigs.k8s.io/cluster-api-provider-azure/hack/tools/bin/kubectl-v1.22.4 get secrets capz-ph31wc-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-ph31wc-control-plane-t4r6p   NotReady   control-plane,master   10s   v1.21.15-rc.0.4+2fef630dd216dd
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-ph31wc-control-plane-t4r6p condition met
node/capz-ph31wc-md-0-8cwvv condition met
... skipping 225 lines ...
Sep  4 04:57:31.141: INFO: PersistentVolumeClaim pvc-lprzh found but phase is Pending instead of Bound.
Sep  4 04:57:33.243: INFO: PersistentVolumeClaim pvc-lprzh found and phase=Bound (23.240106563s)
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  4 04:57:33.552: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-c6h8q" in namespace "azurefile-5194" to be "Succeeded or Failed"
Sep  4 04:57:33.655: INFO: Pod "azurefile-volume-tester-c6h8q": Phase="Pending", Reason="", readiness=false. Elapsed: 102.408786ms
Sep  4 04:57:35.757: INFO: Pod "azurefile-volume-tester-c6h8q": Phase="Pending", Reason="", readiness=false. Elapsed: 2.205319575s
Sep  4 04:57:37.867: INFO: Pod "azurefile-volume-tester-c6h8q": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.315130697s
STEP: Saw pod success
Sep  4 04:57:37.867: INFO: Pod "azurefile-volume-tester-c6h8q" satisfied condition "Succeeded or Failed"
Sep  4 04:57:37.867: INFO: deleting Pod "azurefile-5194"/"azurefile-volume-tester-c6h8q"
Sep  4 04:57:37.983: INFO: Pod azurefile-volume-tester-c6h8q has the following logs: hello world

STEP: Deleting pod azurefile-volume-tester-c6h8q in namespace azurefile-5194
Sep  4 04:57:38.102: INFO: deleting PVC "azurefile-5194"/"pvc-lprzh"
Sep  4 04:57:38.102: INFO: Deleting PersistentVolumeClaim "pvc-lprzh"
... skipping 158 lines ...
Sep  4 04:59:44.052: INFO: PersistentVolumeClaim pvc-xzkwj found but phase is Pending instead of Bound.
Sep  4 04:59:46.156: INFO: PersistentVolumeClaim pvc-xzkwj found and phase=Bound (23.235565242s)
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  4 04:59:46.464: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-24l52" in namespace "azurefile-156" to be "Error status code"
Sep  4 04:59:46.565: INFO: Pod "azurefile-volume-tester-24l52": Phase="Pending", Reason="", readiness=false. Elapsed: 101.525279ms
Sep  4 04:59:48.675: INFO: Pod "azurefile-volume-tester-24l52": Phase="Failed", Reason="", readiness=false. Elapsed: 2.211006505s
STEP: Saw pod failure
Sep  4 04:59:48.675: INFO: Pod "azurefile-volume-tester-24l52" satisfied condition "Error status code"
STEP: checking that pod logs contain expected message
Sep  4 04:59:48.793: INFO: deleting Pod "azurefile-156"/"azurefile-volume-tester-24l52"
Sep  4 04:59:48.898: INFO: Pod azurefile-volume-tester-24l52 has the following logs: touch: /mnt/test-1/data: Read-only file system

STEP: Deleting pod azurefile-volume-tester-24l52 in namespace azurefile-156
Sep  4 04:59:49.017: INFO: deleting PVC "azurefile-156"/"pvc-xzkwj"
... skipping 180 lines ...
Sep  4 05:01:53.351: INFO: PersistentVolumeClaim pvc-4w28w found but phase is Pending instead of Bound.
Sep  4 05:01:55.467: INFO: PersistentVolumeClaim pvc-4w28w found and phase=Bound (2.217747291s)
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  4 05:01:55.791: INFO: Waiting up to 15m0s for pod "azurefile-volume-tester-2x6pt" in namespace "azurefile-2546" to be "Succeeded or Failed"
Sep  4 05:01:55.892: INFO: Pod "azurefile-volume-tester-2x6pt": Phase="Pending", Reason="", readiness=false. Elapsed: 101.314831ms
Sep  4 05:01:58.007: INFO: Pod "azurefile-volume-tester-2x6pt": Phase="Succeeded", Reason="", readiness=false. Elapsed: 2.215971876s
STEP: Saw pod success
Sep  4 05:01:58.007: INFO: Pod "azurefile-volume-tester-2x6pt" 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  4 05:02:28.969: INFO: deleting Pod "azurefile-2546"/"azurefile-volume-tester-2x6pt"
... skipping 734 lines ...
I0904 04:52:52.817014       1 tlsconfig.go:178] loaded client CA [1/"client-ca-bundle::/etc/kubernetes/pki/ca.crt,request-header::/etc/kubernetes/pki/front-proxy-ca.crt"]: "kubernetes" [] issuer="<self>" (2022-09-04 04:45:49 +0000 UTC to 2032-09-01 04:50:49 +0000 UTC (now=2022-09-04 04:52:52.816996641 +0000 UTC))
I0904 04:52:52.817460       1 tlsconfig.go:200] loaded serving cert ["Generated self signed cert"]: "localhost@1662267171" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer="localhost-ca@1662267171" (2022-09-04 03:52:50 +0000 UTC to 2023-09-04 03:52:50 +0000 UTC (now=2022-09-04 04:52:52.817432155 +0000 UTC))
I0904 04:52:52.817835       1 named_certificates.go:53] loaded SNI cert [0/"self-signed loopback"]: "apiserver-loopback-client@1662267172" [serving] validServingFor=[apiserver-loopback-client] issuer="apiserver-loopback-client-ca@1662267172" (2022-09-04 03:52:51 +0000 UTC to 2023-09-04 03:52:51 +0000 UTC (now=2022-09-04 04:52:52.817819468 +0000 UTC))
I0904 04:52:52.817995       1 secure_serving.go:202] Serving securely on 127.0.0.1:10257
I0904 04:52:52.818118       1 tlsconfig.go:240] Starting DynamicServingCertificateController
I0904 04:52:52.818763       1 leaderelection.go:243] attempting to acquire leader lease kube-system/kube-controller-manager...
E0904 04:52:55.199762       1 leaderelection.go:325] 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"
I0904 04:52:55.199893       1 leaderelection.go:248] failed to acquire lease kube-system/kube-controller-manager
I0904 04:52:58.301154       1 leaderelection.go:253] successfully acquired lease kube-system/kube-controller-manager
I0904 04:52:58.301541       1 event.go:291] "Event occurred" object="kube-system/kube-controller-manager" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="capz-ph31wc-control-plane-t4r6p_14f29ef7-7785-49d6-b2ab-505b7600aa77 became leader"
I0904 04:52:58.423939       1 request.go:600] Waited for 94.01041ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/apiextensions.k8s.io/v1?timeout=32s
I0904 04:52:58.473746       1 request.go:600] Waited for 143.83412ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/apiextensions.k8s.io/v1beta1?timeout=32s
I0904 04:52:58.524192       1 request.go:600] Waited for 194.269485ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/scheduling.k8s.io/v1?timeout=32s
I0904 04:52:58.573535       1 request.go:600] Waited for 243.59235ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/apis/scheduling.k8s.io/v1beta1?timeout=32s
... skipping 39 lines ...
I0904 04:52:58.890689       1 reflector.go:219] Starting reflector *v1.Node (12h36m12.930592436s) from k8s.io/client-go/informers/factory.go:134
I0904 04:52:58.893810       1 reflector.go:255] Listing and watching *v1.Node from k8s.io/client-go/informers/factory.go:134
I0904 04:52:58.890887       1 reflector.go:219] Starting reflector *v1.ServiceAccount (12h36m12.930592436s) from k8s.io/client-go/informers/factory.go:134
I0904 04:52:58.894002       1 reflector.go:255] Listing and watching *v1.ServiceAccount from k8s.io/client-go/informers/factory.go:134
I0904 04:52:58.891079       1 reflector.go:219] Starting reflector *v1.Secret (12h36m12.930592436s) from k8s.io/client-go/informers/factory.go:134
I0904 04:52:58.895347       1 reflector.go:255] Listing and watching *v1.Secret from k8s.io/client-go/informers/factory.go:134
W0904 04:52:58.924716       1 azure_config.go:52] 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
I0904 04:52:58.924742       1 controllermanager.go:559] Starting "horizontalpodautoscaling"
I0904 04:52:58.952835       1 controllermanager.go:574] Started "horizontalpodautoscaling"
I0904 04:52:58.952859       1 controllermanager.go:559] Starting "service"
I0904 04:52:58.952999       1 horizontal.go:169] Starting HPA controller
I0904 04:52:58.953016       1 shared_informer.go:240] Waiting for caches to sync for HPA
I0904 04:52:58.959512       1 controllermanager.go:574] Started "service"
... skipping 89 lines ...
I0904 04:52:59.242021       1 plugins.go:639] Loaded volume plugin "kubernetes.io/portworx-volume"
I0904 04:52:59.242050       1 plugins.go:639] Loaded volume plugin "kubernetes.io/scaleio"
I0904 04:52:59.242061       1 plugins.go:639] Loaded volume plugin "kubernetes.io/storageos"
I0904 04:52:59.242182       1 plugins.go:639] Loaded volume plugin "kubernetes.io/fc"
I0904 04:52:59.242237       1 plugins.go:639] Loaded volume plugin "kubernetes.io/iscsi"
I0904 04:52:59.242250       1 plugins.go:639] Loaded volume plugin "kubernetes.io/rbd"
I0904 04:52:59.242296       1 csi_plugin.go:256] Cast from VolumeHost to KubeletVolumeHost failed. Skipping CSINode initialization, not running on kubelet
I0904 04:52:59.242621       1 plugins.go:639] Loaded volume plugin "kubernetes.io/csi"
I0904 04:52:59.242934       1 controllermanager.go:574] Started "attachdetach"
I0904 04:52:59.242956       1 controllermanager.go:559] Starting "endpointslice"
I0904 04:52:59.243002       1 attach_detach_controller.go:328] Starting attach detach controller
I0904 04:52:59.243013       1 shared_informer.go:240] Waiting for caches to sync for attach detach
I0904 04:52:59.392373       1 controllermanager.go:574] Started "endpointslice"
... skipping 6 lines ...
I0904 04:52:59.542012       1 shared_informer.go:240] Waiting for caches to sync for TTL
I0904 04:52:59.542113       1 shared_informer.go:270] caches populated
I0904 04:52:59.542150       1 shared_informer.go:247] Caches are synced for TTL 
I0904 04:52:59.687132       1 controller.go:693] Ignoring node capz-ph31wc-control-plane-t4r6p with Ready condition status False
I0904 04:52:59.687361       1 controller.go:272] Triggering nodeSync
I0904 04:52:59.687553       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-control-plane-t4r6p"
W0904 04:52:59.687707       1 actual_state_of_world.go:539] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="capz-ph31wc-control-plane-t4r6p" does not exist
I0904 04:52:59.700088       1 controllermanager.go:574] Started "ephemeral-volume"
I0904 04:52:59.700127       1 controllermanager.go:559] Starting "endpoint"
I0904 04:52:59.700180       1 controller.go:170] Starting ephemeral volume controller
I0904 04:52:59.700189       1 shared_informer.go:240] Waiting for caches to sync for ephemeral
I0904 04:52:59.707550       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-control-plane-t4r6p"
I0904 04:52:59.741293       1 request.go:600] Waited for 52.147457ms due to client-side throttling, not priority and fairness, request: GET:https://10.0.0.4:6443/api/v1/namespaces/kube-system/serviceaccounts/ttl-controller
... skipping 100 lines ...
I0904 04:53:01.869629       1 plugins.go:639] Loaded volume plugin "kubernetes.io/azure-file"
I0904 04:53:01.869719       1 plugins.go:639] Loaded volume plugin "kubernetes.io/flocker"
I0904 04:53:01.869824       1 plugins.go:639] Loaded volume plugin "kubernetes.io/portworx-volume"
I0904 04:53:01.869848       1 plugins.go:639] Loaded volume plugin "kubernetes.io/scaleio"
I0904 04:53:01.869860       1 plugins.go:639] Loaded volume plugin "kubernetes.io/local-volume"
I0904 04:53:01.869869       1 plugins.go:639] Loaded volume plugin "kubernetes.io/storageos"
I0904 04:53:01.869892       1 csi_plugin.go:256] Cast from VolumeHost to KubeletVolumeHost failed. Skipping CSINode initialization, not running on kubelet
I0904 04:53:01.870012       1 plugins.go:639] Loaded volume plugin "kubernetes.io/csi"
I0904 04:53:01.870102       1 controllermanager.go:574] Started "persistentvolume-binder"
I0904 04:53:01.870122       1 controllermanager.go:559] Starting "pv-protection"
I0904 04:53:01.870166       1 pv_controller_base.go:308] Starting persistent volume controller
I0904 04:53:01.870179       1 shared_informer.go:240] Waiting for caches to sync for persistent volume
I0904 04:53:01.990562       1 controllermanager.go:574] Started "pv-protection"
... skipping 526 lines ...
I0904 04:53:04.274799       1 deployment_util.go:808] Deployment "coredns" timed out (false) [last progress check: 2022-09-04 04:53:04.263816888 +0000 UTC m=+13.587893283 - now: 2022-09-04 04:53:04.274772619 +0000 UTC m=+13.598848914]
I0904 04:53:04.275194       1 event.go:291] "Event occurred" object="kube-system/metrics-server" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set metrics-server-8c95fb79b to 1"
I0904 04:53:04.275606       1 deployment_controller.go:176] "Updating deployment" deployment="kube-system/coredns"
I0904 04:53:04.288166       1 deployment_controller.go:176] "Updating deployment" deployment="kube-system/metrics-server"
I0904 04:53:04.288355       1 deployment_util.go:808] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-04 04:53:04.274261608 +0000 UTC m=+13.598338003 - now: 2022-09-04 04:53:04.288347205 +0000 UTC m=+13.612423600]
I0904 04:53:04.288699       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/coredns" duration="681.77554ms"
I0904 04:53:04.288960       1 deployment_controller.go:490] "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"
I0904 04:53:04.289156       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/coredns" startTime="2022-09-04 04:53:04.289133521 +0000 UTC m=+13.613209916"
I0904 04:53:04.290482       1 deployment_util.go:808] Deployment "coredns" timed out (false) [last progress check: 2022-09-04 04:53:04 +0000 UTC - now: 2022-09-04 04:53:04.290476649 +0000 UTC m=+13.614553044]
I0904 04:53:04.300254       1 deployment_controller.go:176] "Updating deployment" deployment="kube-system/coredns"
I0904 04:53:04.301141       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/coredns" duration="11.989652ms"
I0904 04:53:04.302196       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/coredns" startTime="2022-09-04 04:53:04.302171996 +0000 UTC m=+13.626248391"
I0904 04:53:04.303084       1 deployment_util.go:808] Deployment "coredns" timed out (false) [last progress check: 2022-09-04 04:53:04 +0000 UTC - now: 2022-09-04 04:53:04.303076515 +0000 UTC m=+13.627152910]
I0904 04:53:04.301494       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="118.31919ms"
I0904 04:53:04.303500       1 deployment_controller.go:490] "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"
I0904 04:53:04.304421       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-04 04:53:04.304398142 +0000 UTC m=+13.628474537"
I0904 04:53:04.303449       1 progress.go:195] Queueing up deployment "coredns" for a progress check after 599s
I0904 04:53:04.305768       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/coredns" duration="3.584675ms"
I0904 04:53:04.305722       1 deployment_util.go:808] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-04 04:53:04 +0000 UTC - now: 2022-09-04 04:53:04.30571497 +0000 UTC m=+13.629791365]
I0904 04:53:04.313695       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="9.278596ms"
I0904 04:53:04.313910       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-04 04:53:04.313888242 +0000 UTC m=+13.637964637"
I0904 04:53:04.314644       1 deployment_util.go:808] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-04 04:53:04 +0000 UTC - now: 2022-09-04 04:53:04.314637458 +0000 UTC m=+13.638713753]
I0904 04:53:04.314972       1 deployment_controller.go:176] "Updating deployment" deployment="kube-system/metrics-server"
I0904 04:53:04.318511       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="4.608497ms"
I0904 04:53:04.318913       1 deployment_controller.go:490] "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"
I0904 04:53:04.319126       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-04 04:53:04.319102952 +0000 UTC m=+13.643179247"
I0904 04:53:04.319843       1 deployment_util.go:808] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-04 04:53:04 +0000 UTC - now: 2022-09-04 04:53:04.319836667 +0000 UTC m=+13.643912962]
I0904 04:53:04.320054       1 progress.go:195] Queueing up deployment "metrics-server" for a progress check after 599s
I0904 04:53:04.320192       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="1.053122ms"
I0904 04:53:04.324665       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/metrics-server" startTime="2022-09-04 04:53:04.324601067 +0000 UTC m=+13.648677462"
I0904 04:53:04.325677       1 deployment_util.go:808] Deployment "metrics-server" timed out (false) [last progress check: 2022-09-04 04:53:04 +0000 UTC - now: 2022-09-04 04:53:04.32567079 +0000 UTC m=+13.649747185]
... skipping 111 lines ...
I0904 04:53:06.831150       1 replica_set.go:376] Pod calico-kube-controllers-969cf87c4-x4zb4 created: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"calico-kube-controllers-969cf87c4-x4zb4", GenerateName:"calico-kube-controllers-969cf87c4-", Namespace:"kube-system", SelfLink:"", UID:"d7f674ae-7905-46d0-879e-740edf76bbf1", ResourceVersion:"554", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63797863986, loc:(*time.Location)(0x731ea80)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"k8s-app":"calico-kube-controllers", "pod-template-hash":"969cf87c4"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference{v1.OwnerReference{APIVersion:"apps/v1", Kind:"ReplicaSet", Name:"calico-kube-controllers-969cf87c4", UID:"9fdf2de2-ca73-4683-80fb-3ac2e7b4c6c4", Controller:(*bool)(0xc000e312b7), BlockOwnerDeletion:(*bool)(0xc000e312b8)}}, Finalizers:[]string(nil), ClusterName:"", ManagedFields:[]v1.ManagedFieldsEntry{v1.ManagedFieldsEntry{Manager:"kube-controller-manager", Operation:"Update", APIVersion:"v1", Time:(*v1.Time)(0xc000e048a0), FieldsType:"FieldsV1", FieldsV1:(*v1.FieldsV1)(0xc000e048e8)}}}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"kube-api-access-z45tl", 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)(0xc001272be0), 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-z45tl", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil), SubPathExpr:""}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(0xc00196b3c0), ReadinessProbe:(*v1.Probe)(0xc00196b400), 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)(0xc000e31350), 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)(0xc0006e2540), 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)(0xc000e313b0)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc000e313d0)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"system-cluster-critical", Priority:(*int32)(0xc000e313d8), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc000e313dc), PreemptionPolicy:(*v1.PreemptionPolicy)(0xc001c2a3b0), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil), SetHostnameAsFQDN:(*bool)(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition(nil), Message:"", Reason:"", NominatedNodeName:"", HostIP:"", PodIP:"", PodIPs:[]v1.PodIP(nil), StartTime:(*v1.Time)(nil), InitContainerStatuses:[]v1.ContainerStatus(nil), ContainerStatuses:[]v1.ContainerStatus(nil), QOSClass:"BestEffort", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}.
I0904 04:53:06.831570       1 controller_utils.go:240] Lowered expectations &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-kube-controllers-969cf87c4", timestamp:time.Time{wall:0xc0bd29acb10f2847, ext:16147153330, loc:(*time.Location)(0x731ea80)}}
I0904 04:53:06.832467       1 controller_utils.go:591] Controller calico-kube-controllers-969cf87c4 created pod calico-kube-controllers-969cf87c4-x4zb4
I0904 04:53:06.832665       1 replica_set_utils.go:59] Updating status for : kube-system/calico-kube-controllers-969cf87c4, replicas 0->0 (need 1), fullyLabeledReplicas 0->0, readyReplicas 0->0, availableReplicas 0->0, sequence No: 0->1
I0904 04:53:06.832972       1 event.go:291] "Event occurred" object="kube-system/calico-kube-controllers-969cf87c4" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: calico-kube-controllers-969cf87c4-x4zb4"
I0904 04:53:06.838045       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/calico-kube-controllers" duration="20.407217ms"
I0904 04:53:06.839151       1 deployment_controller.go:490] "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"
I0904 04:53:06.839403       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/calico-kube-controllers" startTime="2022-09-04 04:53:06.839377807 +0000 UTC m=+16.163454102"
I0904 04:53:06.840140       1 deployment_util.go:808] Deployment "calico-kube-controllers" timed out (false) [last progress check: 2022-09-04 04:53:06 +0000 UTC - now: 2022-09-04 04:53:06.840132671 +0000 UTC m=+16.164208966]
I0904 04:53:06.840728       1 replica_set.go:649] Finished syncing ReplicaSet "kube-system/calico-kube-controllers-969cf87c4" (17.848202ms)
I0904 04:53:06.840772       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-kube-controllers-969cf87c4", timestamp:time.Time{wall:0xc0bd29acb10f2847, ext:16147153330, loc:(*time.Location)(0x731ea80)}}
I0904 04:53:06.840876       1 replica_set_utils.go:59] Updating status for : kube-system/calico-kube-controllers-969cf87c4, replicas 0->1 (need 1), fullyLabeledReplicas 0->1, readyReplicas 0->0, availableReplicas 0->0, sequence No: 1->1
I0904 04:53:06.841166       1 deployment_controller.go:281] "ReplicaSet updated" replicaSet="kube-system/calico-kube-controllers-969cf87c4"
... skipping 10 lines ...
I0904 04:53:06.856577       1 deployment_controller.go:281] "ReplicaSet updated" replicaSet="kube-system/calico-kube-controllers-969cf87c4"
I0904 04:53:06.856444       1 replica_set.go:439] Pod calico-kube-controllers-969cf87c4-x4zb4 updated, objectMeta {Name:calico-kube-controllers-969cf87c4-x4zb4 GenerateName:calico-kube-controllers-969cf87c4- Namespace:kube-system SelfLink: UID:d7f674ae-7905-46d0-879e-740edf76bbf1 ResourceVersion:554 Generation:0 CreationTimestamp:2022-09-04 04:53:06 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[k8s-app:calico-kube-controllers pod-template-hash:969cf87c4] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:calico-kube-controllers-969cf87c4 UID:9fdf2de2-ca73-4683-80fb-3ac2e7b4c6c4 Controller:0xc000e312b7 BlockOwnerDeletion:0xc000e312b8}] Finalizers:[] ClusterName: ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-04 04:53:06 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"9fdf2de2-ca73-4683-80fb-3ac2e7b4c6c4\"}":{".":{},"f:apiVersion":{},"f:blockOwnerDeletion":{},"f:controller":{},"f:kind":{},"f:name":{},"f:uid":{}}}},"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:kubernetes.io/os":{}},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}}}]} -> {Name:calico-kube-controllers-969cf87c4-x4zb4 GenerateName:calico-kube-controllers-969cf87c4- Namespace:kube-system SelfLink: UID:d7f674ae-7905-46d0-879e-740edf76bbf1 ResourceVersion:559 Generation:0 CreationTimestamp:2022-09-04 04:53:06 +0000 UTC DeletionTimestamp:<nil> DeletionGracePeriodSeconds:<nil> Labels:map[k8s-app:calico-kube-controllers pod-template-hash:969cf87c4] Annotations:map[] OwnerReferences:[{APIVersion:apps/v1 Kind:ReplicaSet Name:calico-kube-controllers-969cf87c4 UID:9fdf2de2-ca73-4683-80fb-3ac2e7b4c6c4 Controller:0xc000f8e9d7 BlockOwnerDeletion:0xc000f8e9d8}] Finalizers:[] ClusterName: ManagedFields:[{Manager:kube-controller-manager Operation:Update APIVersion:v1 Time:2022-09-04 04:53:06 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:metadata":{"f:generateName":{},"f:labels":{".":{},"f:k8s-app":{},"f:pod-template-hash":{}},"f:ownerReferences":{".":{},"k:{\"uid\":\"9fdf2de2-ca73-4683-80fb-3ac2e7b4c6c4\"}":{".":{},"f:apiVersion":{},"f:blockOwnerDeletion":{},"f:controller":{},"f:kind":{},"f:name":{},"f:uid":{}}}},"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:kubernetes.io/os":{}},"f:priorityClassName":{},"f:restartPolicy":{},"f:schedulerName":{},"f:securityContext":{},"f:serviceAccount":{},"f:serviceAccountName":{},"f:terminationGracePeriodSeconds":{},"f:tolerations":{}}}} {Manager:kube-scheduler Operation:Update APIVersion:v1 Time:2022-09-04 04:53:06 +0000 UTC FieldsType:FieldsV1 FieldsV1:{"f:status":{"f:conditions":{".":{},"k:{\"type\":\"PodScheduled\"}":{".":{},"f:lastProbeTime":{},"f:lastTransitionTime":{},"f:message":{},"f:reason":{},"f:status":{},"f:type":{}}}}}}]}.
I0904 04:53:06.857451       1 replica_set.go:649] Finished syncing ReplicaSet "kube-system/calico-kube-controllers-969cf87c4" (480.24µs)
I0904 04:53:06.857484       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-kube-controllers-969cf87c4", timestamp:time.Time{wall:0xc0bd29acb10f2847, ext:16147153330, loc:(*time.Location)(0x731ea80)}}
I0904 04:53:06.857565       1 replica_set.go:649] Finished syncing ReplicaSet "kube-system/calico-kube-controllers-969cf87c4" (84.907µs)
I0904 04:53:06.858446       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/calico-kube-controllers" duration="6.994189ms"
I0904 04:53:06.858497       1 deployment_controller.go:490] "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"
I0904 04:53:06.858596       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/calico-kube-controllers" startTime="2022-09-04 04:53:06.858526519 +0000 UTC m=+16.182602914"
I0904 04:53:06.862462       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/calico-kube-controllers" duration="3.92323ms"
I0904 04:53:06.862533       1 deployment_controller.go:176] "Updating deployment" deployment="kube-system/calico-kube-controllers"
I0904 04:53:06.862660       1 deployment_controller.go:576] "Started syncing deployment" deployment="kube-system/calico-kube-controllers" startTime="2022-09-04 04:53:06.86258236 +0000 UTC m=+16.186658655"
I0904 04:53:06.863101       1 deployment_util.go:808] Deployment "calico-kube-controllers" timed out (false) [last progress check: 2022-09-04 04:53:06 +0000 UTC - now: 2022-09-04 04:53:06.863095504 +0000 UTC m=+16.187171799]
I0904 04:53:06.863142       1 progress.go:195] Queueing up deployment "calico-kube-controllers" for a progress check after 599s
... skipping 297 lines ...
I0904 04:53:33.669359       1 resource_quota_monitor.go:294] quota monitor not synced: crd.projectcalico.org/v1, Resource=networkpolicies
I0904 04:53:33.706997       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-control-plane-t4r6p"
I0904 04:53:33.773292       1 shared_informer.go:270] caches populated
I0904 04:53:33.773454       1 shared_informer.go:247] Caches are synced for resource quota 
I0904 04:53:33.773487       1 resource_quota_controller.go:454] synced quota controller
I0904 04:53:33.944499       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-control-plane-t4r6p"
W0904 04:53:34.155526       1 garbagecollector.go:703] failed to discover some groups: map[metrics.k8s.io/v1beta1:the server is currently unable to handle the request]
I0904 04:53:34.155962       1 garbagecollector.go:213] 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 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: []
I0904 04:53:34.156047       1 garbagecollector.go:219] reset restmapper
E0904 04:53:34.177832       1 memcache.go:196] couldn't get resource list for metrics.k8s.io/v1beta1: the server is currently unable to handle the request
E0904 04:53:34.183987       1 memcache.go:101] couldn't get resource list for metrics.k8s.io/v1beta1: the server is currently unable to handle the request
I0904 04:53:34.185565       1 graph_builder.go:174] using a shared informer for resource "crd.projectcalico.org/v1, Resource=ipreservations", kind "crd.projectcalico.org/v1, Kind=IPReservation"
I0904 04:53:34.185751       1 graph_builder.go:174] using a shared informer for resource "crd.projectcalico.org/v1, Resource=networkpolicies", kind "crd.projectcalico.org/v1, Kind=NetworkPolicy"
... skipping 83 lines ...
I0904 04:53:38.182342       1 controller.go:291] nodeSync has been triggered
I0904 04:53:38.182367       1 controller.go:776] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0904 04:53:38.182375       1 controller.go:790] Finished updateLoadBalancerHosts
I0904 04:53:38.182380       1 controller.go:731] It took 1.7301e-05 seconds to finish nodeSyncInternal
I0904 04:53:38.200992       1 controller_utils.go:221] Made sure that Node capz-ph31wc-control-plane-t4r6p has no [&Taint{Key:node.kubernetes.io/not-ready,Value:,Effect:NoSchedule,TimeAdded:<nil>,}] Taint
I0904 04:53:38.203370       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-control-plane-t4r6p"
I0904 04:53:38.499847       1 node_lifecycle_controller.go:1039] ReadyCondition for Node capz-ph31wc-control-plane-t4r6p transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-04 04:53:18 +0000 UTC,LastTransitionTime:2022-09-04 04:52:39 +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-04 04:53:38 +0000 UTC,LastTransitionTime:2022-09-04 04:53:38 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0904 04:53:38.499980       1 node_lifecycle_controller.go:1047] Node capz-ph31wc-control-plane-t4r6p ReadyCondition updated. Updating timestamp.
I0904 04:53:38.500005       1 node_lifecycle_controller.go:893] Node capz-ph31wc-control-plane-t4r6p is healthy again, removing all taints
I0904 04:53:38.500025       1 node_lifecycle_controller.go:1191] Controller detected that some Nodes are Ready. Exiting master disruption mode.
I0904 04:53:42.185890       1 daemon_controller.go:571] Pod calico-node-7dgg4 updated.
I0904 04:53:42.186309       1 disruption.go:427] updatePod called on pod "calico-node-7dgg4"
I0904 04:53:42.186434       1 disruption.go:490] No PodDisruptionBudgets found for pod calico-node-7dgg4, PodDisruptionBudget controller will avoid syncing.
... skipping 211 lines ...
I0904 04:54:03.452246       1 gc_controller.go:161] GC'ing orphaned
I0904 04:54:03.452338       1 gc_controller.go:224] GC'ing unscheduled pods which are terminating.
I0904 04:54:03.477062       1 pv_controller_base.go:528] resyncing PV controller
E0904 04:54:03.797617       1 resource_quota_controller.go:409] unable to retrieve the complete list of server APIs: metrics.k8s.io/v1beta1: the server is currently unable to handle the request
I0904 04:54:03.797846       1 resource_quota_controller.go:424] no resource updates from discovery, skipping resource quota sync
I0904 04:54:04.505228       1 httplog.go:94] "HTTP" verb="GET" URI="/healthz" latency="208.706µs" userAgent="kube-probe/1.21+" srcIP="127.0.0.1:46936" resp=200
W0904 04:54:04.640974       1 garbagecollector.go:703] failed to discover some groups: map[metrics.k8s.io/v1beta1:the server is currently unable to handle the request]
I0904 04:54:08.210143       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-control-plane-t4r6p"
I0904 04:54:08.503521       1 node_lifecycle_controller.go:1047] Node capz-ph31wc-control-plane-t4r6p ReadyCondition updated. Updating timestamp.
I0904 04:54:14.504844       1 httplog.go:94] "HTTP" verb="GET" URI="/healthz" latency="73.502µs" userAgent="kube-probe/1.21+" srcIP="127.0.0.1:40400" resp=200
I0904 04:54:18.414270       1 reflector.go:381] k8s.io/client-go/informers/factory.go:134: forcing resync
I0904 04:54:18.477340       1 pv_controller_base.go:528] resyncing PV controller
I0904 04:54:23.452938       1 gc_controller.go:161] GC'ing orphaned
... skipping 92 lines ...
I0904 04:54:37.518718       1 controller.go:776] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0904 04:54:37.518728       1 controller.go:790] Finished updateLoadBalancerHosts
I0904 04:54:37.518734       1 controller.go:731] It took 1.7601e-05 seconds to finish nodeSyncInternal
I0904 04:54:37.518753       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-md-0-hgtw8"
I0904 04:54:37.518868       1 taint_manager.go:435] "Noticed node update" node={nodeName:capz-ph31wc-md-0-hgtw8}
I0904 04:54:37.518885       1 taint_manager.go:440] "Updating known taints on node" node="capz-ph31wc-md-0-hgtw8" taints=[]
W0904 04:54:37.520440       1 actual_state_of_world.go:539] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="capz-ph31wc-md-0-hgtw8" does not exist
I0904 04:54:37.521155       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0bd29ae7104a397, ext:23146464002, loc:(*time.Location)(0x731ea80)}}
I0904 04:54:37.521268       1 controller_utils.go:223] Setting expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0bd29c35f11d70d, ext:106845339256, loc:(*time.Location)(0x731ea80)}}
I0904 04:54:37.521290       1 daemon_controller.go:968] Nodes needing daemon pods for daemon set kube-proxy: [capz-ph31wc-md-0-hgtw8], creating 1
I0904 04:54:37.522978       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-node", timestamp:time.Time{wall:0xc0bd29b58ca13208, ext:51535966991, loc:(*time.Location)(0x731ea80)}}
I0904 04:54:37.523059       1 controller_utils.go:223] Setting expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/calico-node", timestamp:time.Time{wall:0xc0bd29c35f2d32e6, ext:106847132241, loc:(*time.Location)(0x731ea80)}}
I0904 04:54:37.523076       1 daemon_controller.go:968] Nodes needing daemon pods for daemon set calico-node: [capz-ph31wc-md-0-hgtw8], creating 1
... skipping 114 lines ...
I0904 04:54:38.730045       1 controller.go:272] Triggering nodeSync
I0904 04:54:38.730102       1 controller.go:291] nodeSync has been triggered
I0904 04:54:38.730171       1 controller.go:776] Running updateLoadBalancerHosts(len(services)==0, workers==1)
I0904 04:54:38.730264       1 controller.go:790] Finished updateLoadBalancerHosts
I0904 04:54:38.730362       1 controller.go:731] It took 0.00021821 seconds to finish nodeSyncInternal
I0904 04:54:38.730528       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-md-0-8cwvv"
W0904 04:54:38.730593       1 actual_state_of_world.go:539] Failed to update statusUpdateNeeded field in actual state of world: Failed to set statusUpdateNeeded to needed true, because nodeName="capz-ph31wc-md-0-8cwvv" does not exist
I0904 04:54:38.732480       1 taint_manager.go:435] "Noticed node update" node={nodeName:capz-ph31wc-md-0-8cwvv}
I0904 04:54:38.732511       1 taint_manager.go:440] "Updating known taints on node" node="capz-ph31wc-md-0-8cwvv" taints=[]
I0904 04:54:38.733500       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0bd29c3652d8faa, ext:106947819285, loc:(*time.Location)(0x731ea80)}}
I0904 04:54:38.735248       1 controller_utils.go:223] Setting expectations &controller.ControlleeExpectations{add:1, del:0, key:"kube-system/kube-proxy", timestamp:time.Time{wall:0xc0bd29c3abd2dbfc, ext:108059315559, loc:(*time.Location)(0x731ea80)}}
I0904 04:54:38.735288       1 daemon_controller.go:968] Nodes needing daemon pods for daemon set kube-proxy: [capz-ph31wc-md-0-8cwvv], creating 1
I0904 04:54:38.737179       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"kube-system/calico-node", timestamp:time.Time{wall:0xc0bd29c3671fe5a5, ext:106980478224, loc:(*time.Location)(0x731ea80)}}
... skipping 388 lines ...
I0904 04:55:07.663349       1 controller_utils.go:221] Made sure that Node capz-ph31wc-md-0-hgtw8 has no [&Taint{Key:node.kubernetes.io/not-ready,Value:,Effect:NoSchedule,TimeAdded:<nil>,}] Taint
I0904 04:55:07.663637       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-md-0-hgtw8"
I0904 04:55:08.090631       1 azure_vmss.go:369] Can not extract scale set name from providerID (azure:///subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-ph31wc/providers/Microsoft.Compute/virtualMachines/capz-ph31wc-md-0-8cwvv), assuming it is managed by availability set: not a vmss instance
I0904 04:55:08.090799       1 azure_vmss.go:369] Can not extract scale set name from providerID (azure:///subscriptions/0e46bd28-a80f-4d3a-8200-d9eb8d80cb2e/resourceGroups/capz-ph31wc/providers/Microsoft.Compute/virtualMachines/capz-ph31wc-md-0-8cwvv), assuming it is managed by availability set: not a vmss instance
I0904 04:55:08.090857       1 azure_instances.go:239] InstanceShutdownByProviderID gets power status "running" for node "capz-ph31wc-md-0-8cwvv"
I0904 04:55:08.090889       1 azure_instances.go:250] InstanceShutdownByProviderID gets provisioning state "Updating" for node "capz-ph31wc-md-0-8cwvv"
I0904 04:55:08.513647       1 node_lifecycle_controller.go:1039] ReadyCondition for Node capz-ph31wc-md-0-hgtw8 transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-04 04:54:47 +0000 UTC,LastTransitionTime:2022-09-04 04:54:37 +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-04 04:55:07 +0000 UTC,LastTransitionTime:2022-09-04 04:55:07 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0904 04:55:08.513740       1 node_lifecycle_controller.go:1047] Node capz-ph31wc-md-0-hgtw8 ReadyCondition updated. Updating timestamp.
I0904 04:55:08.522534       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-md-0-hgtw8"
I0904 04:55:08.523755       1 taint_manager.go:435] "Noticed node update" node={nodeName:capz-ph31wc-md-0-hgtw8}
I0904 04:55:08.524577       1 taint_manager.go:440] "Updating known taints on node" node="capz-ph31wc-md-0-hgtw8" taints=[]
I0904 04:55:08.524690       1 taint_manager.go:461] "All taints were removed from the node. Cancelling all evictions..." node="capz-ph31wc-md-0-hgtw8"
I0904 04:55:08.524299       1 node_lifecycle_controller.go:893] Node capz-ph31wc-md-0-hgtw8 is healthy again, removing all taints
... skipping 41 lines ...
I0904 04:55:09.876516       1 daemon_controller.go:1030] Pods to delete for daemon set calico-node: [], deleting 0
I0904 04:55:09.876533       1 daemon_controller.go:1103] Updating daemon set status
I0904 04:55:09.876584       1 daemon_controller.go:1163] Finished syncing daemon set "kube-system/calico-node" (1.687254ms)
I0904 04:55:09.876604       1 disruption.go:427] updatePod called on pod "calico-node-tp9rn"
I0904 04:55:09.876629       1 disruption.go:490] No PodDisruptionBudgets found for pod calico-node-tp9rn, PodDisruptionBudget controller will avoid syncing.
I0904 04:55:09.876637       1 disruption.go:430] No matching pdb for pod "calico-node-tp9rn"
I0904 04:55:13.525807       1 node_lifecycle_controller.go:1039] ReadyCondition for Node capz-ph31wc-md-0-8cwvv transitioned from &NodeCondition{Type:Ready,Status:False,LastHeartbeatTime:2022-09-04 04:54:48 +0000 UTC,LastTransitionTime:2022-09-04 04:54: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-04 04:55:08 +0000 UTC,LastTransitionTime:2022-09-04 04:55:08 +0000 UTC,Reason:KubeletReady,Message:kubelet is posting ready status. AppArmor enabled,}
I0904 04:55:13.525871       1 node_lifecycle_controller.go:1047] Node capz-ph31wc-md-0-8cwvv ReadyCondition updated. Updating timestamp.
I0904 04:55:13.538866       1 node_lifecycle_controller.go:893] Node capz-ph31wc-md-0-8cwvv is healthy again, removing all taints
I0904 04:55:13.541157       1 attach_detach_controller.go:673] processVolumesInUse for node "capz-ph31wc-md-0-8cwvv"
I0904 04:55:13.543450       1 taint_manager.go:435] "Noticed node update" node={nodeName:capz-ph31wc-md-0-8cwvv}
I0904 04:55:13.543479       1 taint_manager.go:440] "Updating known taints on node" node="capz-ph31wc-md-0-8cwvv" taints=[]
I0904 04:55:13.543616       1 taint_manager.go:461] "All taints were removed from the node. Cancelling all evictions..." node="capz-ph31wc-md-0-8cwvv"
... skipping 168 lines ...
I0904 04:57:09.964065       1 pv_controller.go:1446] provisionClaim[azurefile-5194/pvc-lprzh]: started
I0904 04:57:09.964110       1 pv_controller.go:1753] scheduleOperation[provision-azurefile-5194/pvc-lprzh[007f1237-36ee-47b9-9f25-7d957be0b46b]]
I0904 04:57:09.964120       1 pv_controller.go:1764] operation "provision-azurefile-5194/pvc-lprzh[007f1237-36ee-47b9-9f25-7d957be0b46b]" is already running, skipping
I0904 04:57:10.020804       1 azure_storageaccount.go:184] azure - no matching account found, begin to create a new account ff799341a7b744521ad24ee in resource group capz-ph31wc, location: northeurope, accountType: Standard_LRS, accountKind: StorageV2, tags: map[created-by:azure]
I0904 04:57:10.686278       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-5466
I0904 04:57:10.723259       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-5466, name default-token-4wcpl, uid 814d06d7-652a-467a-87ed-b6a09eec2407, event type delete
E0904 04:57:10.751743       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-5466/default: secrets "default-token-8q8bg" is forbidden: unable to create new content in namespace azurefile-5466 because it is being terminated
I0904 04:57:10.751875       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-5466, name default, uid c1478221-b7c9-4616-8218-b04a197aaefa, event type delete
I0904 04:57:10.752131       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-5466" (2.3µs)
I0904 04:57:10.752508       1 tokens_controller.go:252] syncServiceAccount(azurefile-5466/default), service account deleted, removing tokens
I0904 04:57:10.846930       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-5466, name kube-root-ca.crt, uid 2cd796be-76e2-4149-b28d-bf7366c52e14, event type delete
I0904 04:57:10.852868       1 publisher.go:181] Finished syncing namespace "azurefile-5466" (5.889376ms)
I0904 04:57:10.865460       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-5466" (2.3µs)
... skipping 1337 lines ...
I0904 04:59:58.658627       1 deployment_util.go:808] Deployment "azurefile-volume-tester-shfwp" timed out (false) [last progress check: 2022-09-04 04:59:58.645777851 +0000 UTC m=+427.969854146 - now: 2022-09-04 04:59:58.658621245 +0000 UTC m=+427.982697540]
I0904 04:59:58.665425       1 deployment_controller.go:281] "ReplicaSet updated" replicaSet="azurefile-1563/azurefile-volume-tester-shfwp-5dd66c57bf"
I0904 04:59:58.665607       1 replica_set.go:649] Finished syncing ReplicaSet "azurefile-1563/azurefile-volume-tester-shfwp-5dd66c57bf" (21.042144ms)
I0904 04:59:58.665648       1 controller_utils.go:189] Controller expectations fulfilled &controller.ControlleeExpectations{add:0, del:0, key:"azurefile-1563/azurefile-volume-tester-shfwp-5dd66c57bf", timestamp:time.Time{wall:0xc0bd2a13a671ce73, ext:427969068922, loc:(*time.Location)(0x731ea80)}}
I0904 04:59:58.665755       1 replica_set_utils.go:59] Updating status for : azurefile-1563/azurefile-volume-tester-shfwp-5dd66c57bf, replicas 0->1 (need 1), fullyLabeledReplicas 0->1, readyReplicas 0->0, availableReplicas 0->0, sequence No: 1->1
I0904 04:59:58.670868       1 deployment_controller.go:578] "Finished syncing deployment" deployment="azurefile-1563/azurefile-volume-tester-shfwp" duration="38.699785ms"
I0904 04:59:58.670915       1 deployment_controller.go:490] "Error syncing deployment" deployment="azurefile-1563/azurefile-volume-tester-shfwp" err="Operation cannot be fulfilled on deployments.apps \"azurefile-volume-tester-shfwp\": the object has been modified; please apply your changes to the latest version and try again"
I0904 04:59:58.670967       1 deployment_controller.go:576] "Started syncing deployment" deployment="azurefile-1563/azurefile-volume-tester-shfwp" startTime="2022-09-04 04:59:58.670934622 +0000 UTC m=+427.995010917"
I0904 04:59:58.671350       1 deployment_util.go:808] Deployment "azurefile-volume-tester-shfwp" timed out (false) [last progress check: 2022-09-04 04:59:58 +0000 UTC - now: 2022-09-04 04:59:58.671344434 +0000 UTC m=+427.995420829]
I0904 04:59:58.671860       1 taint_manager.go:400] "Noticed pod update" pod="azurefile-1563/azurefile-volume-tester-shfwp-5dd66c57bf-w86l9"
I0904 04:59:58.671922       1 disruption.go:427] updatePod called on pod "azurefile-volume-tester-shfwp-5dd66c57bf-w86l9"
I0904 04:59:58.671951       1 disruption.go:490] No PodDisruptionBudgets found for pod azurefile-volume-tester-shfwp-5dd66c57bf-w86l9, PodDisruptionBudget controller will avoid syncing.
I0904 04:59:58.671959       1 disruption.go:430] No matching pdb for pod "azurefile-volume-tester-shfwp-5dd66c57bf-w86l9"
... skipping 25 lines ...
I0904 04:59:59.167006       1 replica_set.go:649] Finished syncing ReplicaSet "azurefile-1563/azurefile-volume-tester-shfwp-5dd66c57bf" (219.407µs)
I0904 04:59:59.748498       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-156
I0904 04:59:59.775072       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-156, name kube-root-ca.crt, uid 870cc4b7-d281-4128-90b0-4ae1d4d47995, event type delete
I0904 04:59:59.778175       1 publisher.go:181] Finished syncing namespace "azurefile-156" (3.039293ms)
I0904 04:59:59.809254       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-156, name azure-storage-account-f45f7d021e2e44c0382032d-secret, uid 96f7569e-3ca6-4e3b-baec-0ca2511ef51a, event type delete
I0904 04:59:59.812572       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-156, name default-token-ll7j2, uid dceb173e-5472-4a1e-b430-8c72178490f2, event type delete
E0904 04:59:59.828160       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-156/default: secrets "default-token-n9spf" is forbidden: unable to create new content in namespace azurefile-156 because it is being terminated
I0904 04:59:59.861755       1 tokens_controller.go:252] syncServiceAccount(azurefile-156/default), service account deleted, removing tokens
I0904 04:59:59.861840       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-156, name default, uid 9c94bf08-f346-4577-88ab-27b255bfee87, event type delete
I0904 04:59:59.861903       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-156" (2.401µs)
I0904 04:59:59.888086       1 resource_quota_monitor.go:355] QuotaMonitor process object: events.k8s.io/v1, Resource=events, namespace azurefile-156, name azurefile-volume-tester-24l52.17118f901310615f, uid 376de5f3-3c1d-4e49-b369-7f816b4f4df3, event type delete
I0904 04:59:59.891877       1 resource_quota_monitor.go:355] QuotaMonitor process object: events.k8s.io/v1, Resource=events, namespace azurefile-156, name azurefile-volume-tester-24l52.17118f905260e21a, uid cac10642-5250-48fa-811d-c7e85a66644f, event type delete
I0904 04:59:59.898568       1 resource_quota_monitor.go:355] QuotaMonitor process object: events.k8s.io/v1, Resource=events, namespace azurefile-156, name azurefile-volume-tester-24l52.17118f9055ca5a8c, uid c66f9e2a-a35d-4ac7-bcf8-cc43c0aef1c9, event type delete
... skipping 1048 lines ...
I0904 05:02:42.131190       1 publisher.go:181] Finished syncing namespace "azurefile-1387" (13.249304ms)
I0904 05:02:42.134308       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1387" (16.667108ms)
I0904 05:02:42.753889       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-3410
I0904 05:02:42.775001       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-3410, name kube-root-ca.crt, uid d36a355e-11d2-4bdb-8b98-cc4294facbf6, event type delete
I0904 05:02:42.778579       1 publisher.go:181] Finished syncing namespace "azurefile-3410" (3.389103ms)
I0904 05:02:42.792427       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-3410, name default-token-qvhpr, uid a39fedee-b27a-4037-94f5-a42bf2632cd8, event type delete
E0904 05:02:42.817273       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-3410/default: secrets "default-token-zkfd2" is forbidden: unable to create new content in namespace azurefile-3410 because it is being terminated
I0904 05:02:42.842458       1 tokens_controller.go:252] syncServiceAccount(azurefile-3410/default), service account deleted, removing tokens
I0904 05:02:42.842633       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-3410, name default, uid cfffcfd0-3b32-4e4d-8239-d34272f8a234, event type delete
I0904 05:02:42.842675       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-3410" (2µs)
I0904 05:02:42.924349       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-3410" (3.4µs)
I0904 05:02:42.925928       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-3410, estimate: 0, errors: <nil>
I0904 05:02:42.946064       1 namespace_controller.go:180] Finished syncing namespace "azurefile-3410" (195.700462ms)
... skipping 4 lines ...
I0904 05:02:43.491574       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-4547" (10.83863ms)
I0904 05:02:43.606468       1 node_lifecycle_controller.go:1047] Node capz-ph31wc-md-0-8cwvv ReadyCondition updated. Updating timestamp.
I0904 05:02:44.175003       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-8582
I0904 05:02:44.216081       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-8582, name kube-root-ca.crt, uid bd61e27f-2b9e-40be-9d28-3eddb48a4fd9, event type delete
I0904 05:02:44.218884       1 publisher.go:181] Finished syncing namespace "azurefile-8582" (2.479976ms)
I0904 05:02:44.267723       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-8582, name default-token-2mjh8, uid c1e4a2d0-c159-465f-a379-229a69b0010d, event type delete
E0904 05:02:44.281790       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-8582/default: secrets "default-token-p7lr7" is forbidden: unable to create new content in namespace azurefile-8582 because it is being terminated
I0904 05:02:44.303858       1 tokens_controller.go:252] syncServiceAccount(azurefile-8582/default), service account deleted, removing tokens
I0904 05:02:44.303935       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-8582, name default, uid 0ce46535-f98b-4bdb-ba00-e87af7fabf78, event type delete
I0904 05:02:44.304348       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-8582" (2.2µs)
I0904 05:02:44.353827       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-8582, estimate: 0, errors: <nil>
I0904 05:02:44.354351       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-8582" (2.8µs)
I0904 05:02:44.370039       1 namespace_controller.go:180] Finished syncing namespace "azurefile-8582" (200.746116ms)
... skipping 18 lines ...
I0904 05:02:46.317703       1 publisher.go:181] Finished syncing namespace "azurefile-9183" (13.411313ms)
I0904 05:02:46.386922       1 reflector.go:530] k8s.io/client-go/informers/factory.go:134: Watch close - *v1.EndpointSlice total 20 items received
I0904 05:02:46.472504       1 namespace_controller.go:185] Namespace has been deleted azurefile-1598
I0904 05:02:46.472531       1 namespace_controller.go:180] Finished syncing namespace "azurefile-1598" (68.802µs)
I0904 05:02:47.003511       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-3086
I0904 05:02:47.033595       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-3086, name default-token-8rbs9, uid 0a60d441-63e5-4b62-aba1-38aa67a7ce99, event type delete
E0904 05:02:47.059285       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-3086/default: secrets "default-token-nz8ww" is forbidden: unable to create new content in namespace azurefile-3086 because it is being terminated
I0904 05:02:47.085619       1 tokens_controller.go:252] syncServiceAccount(azurefile-3086/default), service account deleted, removing tokens
I0904 05:02:47.085876       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-3086, name default, uid e882ab42-f2e3-49e0-a942-921a8aba9f15, event type delete
I0904 05:02:47.085893       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-3086" (2.9µs)
I0904 05:02:47.133576       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-3086, name kube-root-ca.crt, uid 152966f4-92e9-43eb-8661-924ddc821c02, event type delete
I0904 05:02:47.135328       1 publisher.go:181] Finished syncing namespace "azurefile-3086" (1.680552ms)
I0904 05:02:47.160729       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-3086" (2.8µs)
... skipping 4 lines ...
I0904 05:02:47.676169       1 publisher.go:181] Finished syncing namespace "azurefile-7578" (10.125612ms)
I0904 05:02:47.924714       1 namespace_controller.go:185] Namespace has been deleted azurefile-3410
I0904 05:02:47.924894       1 namespace_controller.go:180] Finished syncing namespace "azurefile-3410" (212.007µs)
I0904 05:02:48.379525       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-1387
I0904 05:02:48.418180       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-1387, name default-token-xpv7v, uid 74906425-82df-45b4-848c-5299f5c0867f, event type delete
I0904 05:02:48.441440       1 reflector.go:381] k8s.io/client-go/informers/factory.go:134: forcing resync
E0904 05:02:48.445333       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-1387/default: secrets "default-token-r6xn7" is forbidden: unable to create new content in namespace azurefile-1387 because it is being terminated
I0904 05:02:48.450576       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-1387, name kube-root-ca.crt, uid 5b6118b6-9a7e-400e-8567-590d6e20a906, event type delete
I0904 05:02:48.453804       1 publisher.go:181] Finished syncing namespace "azurefile-1387" (3.177398ms)
I0904 05:02:48.471510       1 tokens_controller.go:252] syncServiceAccount(azurefile-1387/default), service account deleted, removing tokens
I0904 05:02:48.471583       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-1387, name default, uid 9b39de8b-e023-48f7-be95-cab019b61016, event type delete
I0904 05:02:48.471619       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1387" (1.7µs)
I0904 05:02:48.502867       1 pv_controller_base.go:528] resyncing PV controller
... skipping 6 lines ...
I0904 05:02:49.354785       1 namespace_controller.go:185] Namespace has been deleted azurefile-8582
I0904 05:02:49.354900       1 namespace_controller.go:180] Finished syncing namespace "azurefile-8582" (134.504µs)
I0904 05:02:49.795920       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-4547
I0904 05:02:49.851532       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-4547, name kube-root-ca.crt, uid 4ee665a3-db3d-4d1a-a5b7-a295a94e024c, event type delete
I0904 05:02:49.853618       1 publisher.go:181] Finished syncing namespace "azurefile-4547" (1.861057ms)
I0904 05:02:49.901338       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-4547, name default-token-xqtds, uid 471cb9c3-37eb-4f86-9f58-de4e6b7a8794, event type delete
E0904 05:02:49.914904       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-4547/default: secrets "default-token-shkg6" is forbidden: unable to create new content in namespace azurefile-4547 because it is being terminated
I0904 05:02:49.924967       1 tokens_controller.go:252] syncServiceAccount(azurefile-4547/default), service account deleted, removing tokens
I0904 05:02:49.925260       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-4547" (3.7µs)
I0904 05:02:49.925308       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-4547, name default, uid 28a54eba-760b-4976-ac8e-dec6d1fa4175, event type delete
I0904 05:02:49.933629       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-4547, estimate: 0, errors: <nil>
I0904 05:02:49.934648       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-4547" (2.2µs)
I0904 05:02:49.947427       1 namespace_controller.go:180] Finished syncing namespace "azurefile-4547" (155.291387ms)
... skipping 16 lines ...
I0904 05:02:51.905450       1 publisher.go:181] Finished syncing namespace "azurefile-1359" (11.158044ms)
I0904 05:02:51.905658       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1359" (11.081841ms)
I0904 05:02:52.161638       1 namespace_controller.go:185] Namespace has been deleted azurefile-3086
I0904 05:02:52.161661       1 namespace_controller.go:180] Finished syncing namespace "azurefile-3086" (46.301µs)
I0904 05:02:52.569554       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-9183
I0904 05:02:52.630426       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-9183, name default-token-cvfqh, uid 8691806d-3dbc-45f5-a251-89f911d507a8, event type delete
E0904 05:02:52.658591       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-9183/default: secrets "default-token-nvk2s" is forbidden: unable to create new content in namespace azurefile-9183 because it is being terminated
I0904 05:02:52.686484       1 tokens_controller.go:252] syncServiceAccount(azurefile-9183/default), service account deleted, removing tokens
I0904 05:02:52.686542       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-9183, name default, uid b88e1041-4605-4f8e-94b1-c0c321184cfc, event type delete
I0904 05:02:52.686572       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-9183" (1.9µs)
I0904 05:02:52.760169       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-9183, name kube-root-ca.crt, uid 143e3fc9-725a-418c-9112-a1df80d87a4c, event type delete
I0904 05:02:52.763170       1 publisher.go:181] Finished syncing namespace "azurefile-9183" (2.962491ms)
I0904 05:02:52.770815       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-9183" (2.6µs)
... skipping 3 lines ...
I0904 05:02:53.317526       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-565" (7.855641ms)
I0904 05:02:53.321491       1 publisher.go:181] Finished syncing namespace "azurefile-565" (11.736759ms)
I0904 05:02:53.550768       1 namespace_controller.go:185] Namespace has been deleted azurefile-1387
I0904 05:02:53.550800       1 namespace_controller.go:180] Finished syncing namespace "azurefile-1387" (55.102µs)
I0904 05:02:53.970992       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-7578
I0904 05:02:54.069074       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-7578, name default-token-bvgfv, uid 0ba85968-9fdd-4703-8c57-b98f3c5c405e, event type delete
E0904 05:02:54.092870       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-7578/default: secrets "default-token-gzld6" is forbidden: unable to create new content in namespace azurefile-7578 because it is being terminated
I0904 05:02:54.115928       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-7578, name kube-root-ca.crt, uid 6cb46d3e-b48f-4ad1-8b23-b590e46f80d7, event type delete
I0904 05:02:54.125431       1 publisher.go:181] Finished syncing namespace "azurefile-7578" (9.453089ms)
I0904 05:02:54.141148       1 tokens_controller.go:252] syncServiceAccount(azurefile-7578/default), service account deleted, removing tokens
I0904 05:02:54.141257       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-7578, name default, uid 7b058884-05d6-4fe3-954e-c662fc3dfcce, event type delete
I0904 05:02:54.141292       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-7578" (1.8µs)
I0904 05:02:54.154769       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-7578, estimate: 0, errors: <nil>
... skipping 4 lines ...
I0904 05:02:54.693516       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-8666" (6.036984ms)
I0904 05:02:54.696689       1 publisher.go:181] Finished syncing namespace "azurefile-8666" (8.887972ms)
I0904 05:02:54.935187       1 namespace_controller.go:185] Namespace has been deleted azurefile-4547
I0904 05:02:54.935213       1 namespace_controller.go:180] Finished syncing namespace "azurefile-4547" (47.901µs)
I0904 05:02:55.398810       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-1968
I0904 05:02:55.457787       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-1968, name default-token-r9t5p, uid 5169020f-2791-4dc5-b988-9cd5de881b57, event type delete
E0904 05:02:55.488709       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-1968/default: secrets "default-token-jr4ls" is forbidden: unable to create new content in namespace azurefile-1968 because it is being terminated
I0904 05:02:55.591612       1 tokens_controller.go:252] syncServiceAccount(azurefile-1968/default), service account deleted, removing tokens
I0904 05:02:55.591669       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-1968, name default, uid 8543e56a-fd45-4c47-810f-a6fb92c2c00b, event type delete
I0904 05:02:55.591702       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1968" (2µs)
I0904 05:02:55.629636       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-1968, name kube-root-ca.crt, uid b74924e1-addb-4679-b0f8-e2067b6d3888, event type delete
I0904 05:02:55.633194       1 publisher.go:181] Finished syncing namespace "azurefile-1968" (3.344702ms)
I0904 05:02:55.656181       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1968" (2.8µs)
... skipping 5 lines ...
I0904 05:02:56.352694       1 namespace_controller.go:185] Namespace has been deleted azurefile-7051
I0904 05:02:56.352720       1 namespace_controller.go:180] Finished syncing namespace "azurefile-7051" (45.802µs)
I0904 05:02:56.790544       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-4657
I0904 05:02:56.866085       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-4657, name kube-root-ca.crt, uid e608a40e-9061-47fd-a8b0-625b3e314769, event type delete
I0904 05:02:56.869085       1 publisher.go:181] Finished syncing namespace "azurefile-4657" (2.985692ms)
I0904 05:02:56.913172       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-4657, name default-token-4x6dl, uid af0c08c7-aa10-4c0b-87c7-da797fb102e3, event type delete
E0904 05:02:56.929805       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-4657/default: secrets "default-token-j5lnp" is forbidden: unable to create new content in namespace azurefile-4657 because it is being terminated
I0904 05:02:56.941160       1 tokens_controller.go:252] syncServiceAccount(azurefile-4657/default), service account deleted, removing tokens
I0904 05:02:56.941226       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-4657, name default, uid 0b2fbb5f-46cc-4282-bc7d-2c19edc40d0b, event type delete
I0904 05:02:56.941416       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-4657" (2.7µs)
I0904 05:02:56.967243       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-4657" (1.7µs)
I0904 05:02:56.967715       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-4657, estimate: 0, errors: <nil>
I0904 05:02:56.975751       1 namespace_controller.go:180] Finished syncing namespace "azurefile-4657" (189.453996ms)
... skipping 3 lines ...
I0904 05:02:57.770991       1 namespace_controller.go:185] Namespace has been deleted azurefile-9183
I0904 05:02:57.771039       1 namespace_controller.go:180] Finished syncing namespace "azurefile-9183" (77.003µs)
I0904 05:02:58.206385       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-1359
I0904 05:02:58.247353       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-1359, name kube-root-ca.crt, uid fee89ffd-2f3f-4968-b1a1-c45bcd8daf14, event type delete
I0904 05:02:58.250282       1 publisher.go:181] Finished syncing namespace "azurefile-1359" (2.758284ms)
I0904 05:02:58.282872       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-1359, name default-token-ng7pg, uid 491d814a-4350-46fc-af1f-ab483510780f, event type delete
E0904 05:02:58.295772       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-1359/default: secrets "default-token-pszhc" is forbidden: unable to create new content in namespace azurefile-1359 because it is being terminated
I0904 05:02:58.341136       1 tokens_controller.go:252] syncServiceAccount(azurefile-1359/default), service account deleted, removing tokens
I0904 05:02:58.341262       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-1359, name default, uid 8b5e6e77-61cc-4a5f-8d06-f322c3da3631, event type delete
I0904 05:02:58.341344       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1359" (2.1µs)
I0904 05:02:58.353633       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-1359, estimate: 0, errors: <nil>
I0904 05:02:58.354171       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1359" (2.8µs)
I0904 05:02:58.362151       1 namespace_controller.go:180] Finished syncing namespace "azurefile-1359" (159.130668ms)
I0904 05:02:58.739184       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-6611" (3µs)
I0904 05:02:58.859013       1 publisher.go:181] Finished syncing namespace "azurefile-6157" (6.900511ms)
I0904 05:02:58.860171       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-6157" (8.339755ms)
I0904 05:02:59.155896       1 namespace_controller.go:185] Namespace has been deleted azurefile-7578
I0904 05:02:59.155928       1 namespace_controller.go:180] Finished syncing namespace "azurefile-7578" (75.402µs)
I0904 05:02:59.586797       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-565
I0904 05:02:59.686119       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-565, name default-token-n48pd, uid 634756df-0f18-49ef-b90a-c478dd19ac60, event type delete
E0904 05:02:59.700787       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-565/default: secrets "default-token-ctgk6" is forbidden: unable to create new content in namespace azurefile-565 because it is being terminated
I0904 05:02:59.706692       1 tokens_controller.go:252] syncServiceAccount(azurefile-565/default), service account deleted, removing tokens
I0904 05:02:59.707615       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-565, name default, uid 9c25052a-e26f-4d3b-a113-f95d2ab528fe, event type delete
I0904 05:02:59.707659       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-565" (2.1µs)
I0904 05:02:59.713361       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-565, name kube-root-ca.crt, uid 48d273d3-491a-4c74-9b2f-d2c7425d82be, event type delete
I0904 05:02:59.714973       1 publisher.go:181] Finished syncing namespace "azurefile-565" (1.563748ms)
I0904 05:02:59.762620       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-565" (3.2µs)
... skipping 5 lines ...
I0904 05:03:00.657257       1 namespace_controller.go:185] Namespace has been deleted azurefile-1968
I0904 05:03:00.657327       1 namespace_controller.go:180] Finished syncing namespace "azurefile-1968" (100.203µs)
I0904 05:03:00.958022       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-8666
I0904 05:03:00.994343       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-8666, name default-token-jcvg2, uid 978c87e0-3d10-490d-ace0-599ed3c54ff1, event type delete
I0904 05:03:01.003569       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-8666, name kube-root-ca.crt, uid 370a2e98-66d2-42c9-8193-da04e1dcb126, event type delete
I0904 05:03:01.008213       1 publisher.go:181] Finished syncing namespace "azurefile-8666" (4.825347ms)
E0904 05:03:01.010171       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-8666/default: secrets "default-token-s6tgl" is forbidden: unable to create new content in namespace azurefile-8666 because it is being terminated
I0904 05:03:01.047952       1 tokens_controller.go:252] syncServiceAccount(azurefile-8666/default), service account deleted, removing tokens
I0904 05:03:01.048042       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-8666, name default, uid 2d1cd764-0255-4648-9fa3-7191b759203c, event type delete
I0904 05:03:01.048151       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-8666" (2µs)
I0904 05:03:01.112415       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-8666" (3.601µs)
I0904 05:03:01.117390       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-8666, estimate: 0, errors: <nil>
I0904 05:03:01.126399       1 namespace_controller.go:180] Finished syncing namespace "azurefile-8666" (173.706484ms)
I0904 05:03:01.517185       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-1393" (2.9µs)
I0904 05:03:01.629507       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-3922" (6.834608ms)
I0904 05:03:01.634534       1 publisher.go:181] Finished syncing namespace "azurefile-3922" (11.84836ms)
I0904 05:03:01.967563       1 namespace_controller.go:185] Namespace has been deleted azurefile-4657
I0904 05:03:01.967587       1 namespace_controller.go:180] Finished syncing namespace "azurefile-4657" (45.601µs)
I0904 05:03:02.385463       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-7886
I0904 05:03:02.419327       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-7886, name default-token-92hkg, uid 31026e34-79d8-46b7-a38a-b38e8efdfd3f, event type delete
E0904 05:03:02.434497       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-7886/default: secrets "default-token-vxtbw" is forbidden: unable to create new content in namespace azurefile-7886 because it is being terminated
I0904 05:03:02.443085       1 tokens_controller.go:252] syncServiceAccount(azurefile-7886/default), service account deleted, removing tokens
I0904 05:03:02.443891       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-7886, name default, uid 465be7a4-ffec-44d8-a933-d3279708e9a4, event type delete
I0904 05:03:02.443981       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-7886" (2.6µs)
I0904 05:03:02.525917       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-7886, name kube-root-ca.crt, uid 30b2cc4e-0dcf-4ea1-ad98-458c76cfb15c, event type delete
I0904 05:03:02.528794       1 publisher.go:181] Finished syncing namespace "azurefile-7886" (2.61778ms)
I0904 05:03:02.557605       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-7886, estimate: 0, errors: <nil>
... skipping 16 lines ...
I0904 05:03:03.503236       1 pv_controller_base.go:528] resyncing PV controller
I0904 05:03:03.645143       1 resource_quota_controller.go:194] Resource quota controller queued all resource quota for full calculation of usage
I0904 05:03:03.744279       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-6611
I0904 05:03:03.791134       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-6611, name kube-root-ca.crt, uid cc176073-a62d-446f-a02c-9f412660772b, event type delete
I0904 05:03:03.792966       1 publisher.go:181] Finished syncing namespace "azurefile-6611" (1.780254ms)
I0904 05:03:03.797524       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-6611, name default-token-wbb22, uid 6f424054-13a0-4423-bf38-2256245f4376, event type delete
E0904 05:03:03.811309       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-6611/default: secrets "default-token-vfbcx" is forbidden: unable to create new content in namespace azurefile-6611 because it is being terminated
I0904 05:03:03.870794       1 tokens_controller.go:252] syncServiceAccount(azurefile-6611/default), service account deleted, removing tokens
I0904 05:03:03.870866       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-6611, name default, uid 91158849-673e-4628-97f3-c6f71ca19982, event type delete
I0904 05:03:03.870904       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-6611" (1.9µs)
I0904 05:03:03.892984       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-6611" (1.9µs)
I0904 05:03:03.893495       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-6611, estimate: 0, errors: <nil>
I0904 05:03:03.904218       1 namespace_controller.go:180] Finished syncing namespace "azurefile-6611" (164.179595ms)
... skipping 6 lines ...
I0904 05:03:05.001920       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/metrics-server" duration="890.727µs"
I0904 05:03:05.001965       1 deployment_controller.go:578] "Finished syncing deployment" deployment="kube-system/coredns" duration="938.429µs"
I0904 05:03:05.109869       1 namespaced_resources_deleter.go:500] namespace controller - deleteAllContent - namespace: azurefile-6157
I0904 05:03:05.180414       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=configmaps, namespace azurefile-6157, name kube-root-ca.crt, uid 8e8a988f-449e-44fd-a187-4a5443690dbd, event type delete
I0904 05:03:05.182531       1 publisher.go:181] Finished syncing namespace "azurefile-6157" (2.060762ms)
I0904 05:03:05.224242       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=secrets, namespace azurefile-6157, name default-token-htx4p, uid 8bd34158-bb82-4363-8bd4-506c49b565a3, event type delete
E0904 05:03:05.242435       1 tokens_controller.go:262] error synchronizing serviceaccount azurefile-6157/default: secrets "default-token-rh527" is forbidden: unable to create new content in namespace azurefile-6157 because it is being terminated
I0904 05:03:05.274991       1 resource_quota_monitor.go:355] QuotaMonitor process object: /v1, Resource=serviceaccounts, namespace azurefile-6157, name default, uid b54bf3c0-77ac-4283-8d8e-1887d7886c22, event type delete
I0904 05:03:05.275459       1 tokens_controller.go:252] syncServiceAccount(azurefile-6157/default), service account deleted, removing tokens
I0904 05:03:05.275792       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-6157" (3µs)
I0904 05:03:05.287870       1 serviceaccounts_controller.go:188] Finished syncing namespace "azurefile-6157" (2.2µs)
I0904 05:03:05.288193       1 namespaced_resources_deleter.go:554] namespace controller - deleteAllContent - namespace: azurefile-6157, estimate: 0, errors: <nil>
I0904 05:03:05.297568       1 namespace_controller.go:180] Finished syncing namespace "azurefile-6157" (189.848176ms)
2022/09/04 05:03:06 ===================================================

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

Ran 6 of 34 Specs in 366.854 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 37 lines ...
INFO: Creating log watcher for controller capz-system/capz-controller-manager, pod capz-controller-manager-858df9cd95-bnqtb, container manager
STEP: Dumping workload cluster default/capz-ph31wc logs
Sep  4 05:04:33.005: INFO: Collecting logs for Linux node capz-ph31wc-control-plane-t4r6p in cluster capz-ph31wc in namespace default

Sep  4 05:05:33.008: INFO: Collecting boot logs for AzureMachine capz-ph31wc-control-plane-t4r6p

Failed to get logs for machine capz-ph31wc-control-plane-xnczq, cluster default/capz-ph31wc: open /etc/azure-ssh/azure-ssh: no such file or directory
Sep  4 05:05:34.321: INFO: Collecting logs for Linux node capz-ph31wc-md-0-8cwvv in cluster capz-ph31wc in namespace default

Sep  4 05:06:34.322: INFO: Collecting boot logs for AzureMachine capz-ph31wc-md-0-8cwvv

Failed to get logs for machine capz-ph31wc-md-0-759799c484-2sgfv, cluster default/capz-ph31wc: open /etc/azure-ssh/azure-ssh: no such file or directory
Sep  4 05:06:34.864: INFO: Collecting logs for Linux node capz-ph31wc-md-0-hgtw8 in cluster capz-ph31wc in namespace default

Sep  4 05:07:34.865: INFO: Collecting boot logs for AzureMachine capz-ph31wc-md-0-hgtw8

Failed to get logs for machine capz-ph31wc-md-0-759799c484-t8m2w, cluster default/capz-ph31wc: open /etc/azure-ssh/azure-ssh: no such file or directory
STEP: Dumping workload cluster default/capz-ph31wc kube-system pod logs
STEP: Fetching kube-system pod logs took 1.243365626s
STEP: Dumping workload cluster default/capz-ph31wc Azure activity log
STEP: Creating log watcher for controller kube-system/etcd-capz-ph31wc-control-plane-t4r6p, container etcd
STEP: Collecting events for Pod kube-system/calico-node-spm4l
STEP: Collecting events for Pod kube-system/calico-kube-controllers-969cf87c4-x4zb4
... skipping 6 lines ...
STEP: Creating log watcher for controller kube-system/kube-controller-manager-capz-ph31wc-control-plane-t4r6p, container kube-controller-manager
STEP: Creating log watcher for controller kube-system/kube-proxy-bnbwd, container kube-proxy
STEP: Creating log watcher for controller kube-system/calico-kube-controllers-969cf87c4-x4zb4, container calico-kube-controllers
STEP: Creating log watcher for controller kube-system/kube-scheduler-capz-ph31wc-control-plane-t4r6p, container kube-scheduler
STEP: Creating log watcher for controller kube-system/metrics-server-8c95fb79b-9dgrt, container metrics-server
STEP: Collecting events for Pod kube-system/kube-controller-manager-capz-ph31wc-control-plane-t4r6p
STEP: failed to find events of Pod "kube-controller-manager-capz-ph31wc-control-plane-t4r6p"
STEP: Creating log watcher for controller kube-system/kube-proxy-z4rr9, container kube-proxy
STEP: Collecting events for Pod kube-system/calico-node-7dgg4
STEP: Creating log watcher for controller kube-system/calico-node-spm4l, container calico-node
STEP: Collecting events for Pod kube-system/kube-proxy-z4rr9
STEP: Collecting events for Pod kube-system/kube-scheduler-capz-ph31wc-control-plane-t4r6p
STEP: failed to find events of Pod "kube-scheduler-capz-ph31wc-control-plane-t4r6p"
STEP: Collecting events for Pod kube-system/kube-proxy-vwrdf
STEP: Creating log watcher for controller kube-system/coredns-558bd4d5db-4nxml, container coredns
STEP: Collecting events for Pod kube-system/metrics-server-8c95fb79b-9dgrt
STEP: Creating log watcher for controller kube-system/calico-node-tp9rn, container calico-node
STEP: Creating log watcher for controller kube-system/coredns-558bd4d5db-9dtfg, container coredns
STEP: Collecting events for Pod kube-system/coredns-558bd4d5db-9dtfg
... skipping 20 lines ...