I0330 21:08:34.935333 1 serving.go:386] Generated self-signed cert in-memory I0330 21:08:35.315491 1 controllermanager.go:191] "Starting" version="v1.34.0" I0330 21:08:35.315513 1 controllermanager.go:193] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0330 21:08:35.319770 1 dynamic_cafile_content.go:161] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0330 21:08:35.320437 1 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0330 21:08:35.322217 1 secure_serving.go:211] Serving securely on [::]:10257 I0330 21:08:35.322860 1 tlsconfig.go:243] "Starting DynamicServingCertificateController" I0330 21:08:35.322946 1 leaderelection.go:257] attempting to acquire leader lease kube-system/kube-controller-manager... E0330 21:08:36.079191 1 leaderelection.go:448] 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" I0330 21:08:39.713662 1 leaderelection.go:271] successfully acquired lease kube-system/kube-controller-manager I0330 21:08:39.713963 1 event.go:389] "Event occurred" object="kube-system/kube-controller-manager" fieldPath="" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="controller_c96a079b-0ac4-46fd-8cba-756ff8d87458 became leader" I0330 21:08:39.717747 1 controllermanager.go:781] "Started controller" controller="serviceaccount-token-controller" I0330 21:08:39.717795 1 shared_informer.go:349] "Waiting for caches to sync" controller="tokens" I0330 21:08:39.726842 1 node_lifecycle_controller.go:419] "Controller will reconcile labels" logger="node-lifecycle-controller" I0330 21:08:39.726877 1 controllermanager.go:781] "Started controller" controller="node-lifecycle-controller" I0330 21:08:39.727053 1 node_lifecycle_controller.go:453] "Sending events to api server" logger="node-lifecycle-controller" I0330 21:08:39.727072 1 node_lifecycle_controller.go:464] "Starting node controller" logger="node-lifecycle-controller" I0330 21:08:39.727079 1 shared_informer.go:349] "Waiting for caches to sync" controller="taint" I0330 21:08:39.733233 1 controllermanager.go:781] "Started controller" controller="persistentvolume-expander-controller" I0330 21:08:39.733326 1 expand_controller.go:327] "Starting expand controller" logger="persistentvolume-expander-controller" I0330 21:08:39.733338 1 shared_informer.go:349] "Waiting for caches to sync" controller="expand" I0330 21:08:39.741147 1 controllermanager.go:781] "Started controller" controller="statefulset-controller" I0330 21:08:39.741370 1 stateful_set.go:169] "Starting stateful set controller" logger="statefulset-controller" I0330 21:08:39.741390 1 shared_informer.go:349] "Waiting for caches to sync" controller="stateful set" I0330 21:08:39.748100 1 controllermanager.go:781] "Started controller" controller="bootstrap-signer-controller" I0330 21:08:39.748167 1 shared_informer.go:349] "Waiting for caches to sync" controller="bootstrap_signer" I0330 21:08:39.754999 1 controllermanager.go:781] "Started controller" controller="volumeattributesclass-protection-controller" I0330 21:08:39.755030 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="storageversion-garbage-collector-controller" requiredFeatureGates=["APIServerIdentity","StorageVersionAPI"] I0330 21:08:39.755066 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="device-taint-eviction-controller" requiredFeatureGates=["DynamicResourceAllocation","DRADeviceTaints"] I0330 21:08:39.755157 1 vac_protection_controller.go:206] "Starting VAC protection controller" logger="volumeattributesclass-protection-controller" I0330 21:08:39.755180 1 shared_informer.go:349] "Waiting for caches to sync" controller="VAC protection" I0330 21:08:39.763009 1 controllermanager.go:781] "Started controller" controller="replicationcontroller-controller" I0330 21:08:39.763218 1 replica_set.go:243] "Starting controller" logger="replicationcontroller-controller" name="replicationcontroller" I0330 21:08:39.763308 1 shared_informer.go:349] "Waiting for caches to sync" controller="ReplicationController" I0330 21:08:39.771645 1 controllermanager.go:781] "Started controller" controller="serviceaccount-controller" I0330 21:08:39.771682 1 serviceaccounts_controller.go:114] "Starting service account controller" logger="serviceaccount-controller" I0330 21:08:39.771700 1 shared_informer.go:349] "Waiting for caches to sync" controller="service account" I0330 21:08:39.779309 1 controllermanager.go:781] "Started controller" controller="ttl-controller" I0330 21:08:39.779446 1 ttl_controller.go:127] "Starting TTL controller" logger="ttl-controller" I0330 21:08:39.779475 1 shared_informer.go:349] "Waiting for caches to sync" controller="TTL" I0330 21:08:39.786588 1 controllermanager.go:781] "Started controller" controller="persistentvolume-protection-controller" I0330 21:08:39.786743 1 pv_protection_controller.go:81] "Starting PV protection controller" logger="persistentvolume-protection-controller" I0330 21:08:39.786763 1 shared_informer.go:349] "Waiting for caches to sync" controller="PV protection" I0330 21:08:39.793337 1 controllermanager.go:781] "Started controller" controller="root-ca-certificate-publisher-controller" I0330 21:08:39.793353 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="kube-apiserver-serving-clustertrustbundle-publisher-controller" requiredFeatureGates=["ClusterTrustBundle"] I0330 21:08:39.793370 1 controllermanager.go:759] "Warning: skipping controller" controller="storage-version-migrator-controller" I0330 21:08:39.793376 1 controllermanager.go:759] "Warning: skipping controller" controller="node-ipam-controller" I0330 21:08:39.793430 1 publisher.go:107] "Starting root CA cert publisher controller" logger="root-ca-certificate-publisher-controller" I0330 21:08:39.793445 1 shared_informer.go:349] "Waiting for caches to sync" controller="crt configmap" I0330 21:08:39.818781 1 shared_informer.go:356] "Caches are synced" controller="tokens" I0330 21:08:39.920257 1 controllermanager.go:781] "Started controller" controller="persistentvolume-binder-controller" I0330 21:08:39.920581 1 pv_controller_base.go:308] "Starting persistent volume controller" logger="persistentvolume-binder-controller" I0330 21:08:39.920601 1 shared_informer.go:349] "Waiting for caches to sync" controller="persistent volume" I0330 21:08:40.117821 1 controllermanager.go:781] "Started controller" controller="validatingadmissionpolicy-status-controller" I0330 21:08:40.117892 1 shared_informer.go:349] "Waiting for caches to sync" controller="validatingadmissionpolicy-status" I0330 21:08:40.168416 1 controllermanager.go:781] "Started controller" controller="taint-eviction-controller" I0330 21:08:40.168484 1 taint_eviction.go:282] "Starting" logger="taint-eviction-controller" controller="taint-eviction-controller" I0330 21:08:40.168506 1 taint_eviction.go:288] "Sending events to api server" logger="taint-eviction-controller" I0330 21:08:40.168527 1 shared_informer.go:349] "Waiting for caches to sync" controller="taint-eviction-controller" I0330 21:08:40.319306 1 controllermanager.go:781] "Started controller" controller="endpointslice-controller" I0330 21:08:40.319540 1 endpointslice_controller.go:281] "Starting endpoint slice controller" logger="endpointslice-controller" I0330 21:08:40.319577 1 shared_informer.go:349] "Waiting for caches to sync" controller="endpoint_slice" I0330 21:08:40.566608 1 garbagecollector.go:144] "Starting controller" logger="garbage-collector-controller" controller="garbagecollector" I0330 21:08:40.566636 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0330 21:08:40.566663 1 graph_builder.go:351] "Running" logger="garbage-collector-controller" component="GraphBuilder" I0330 21:08:40.566793 1 controllermanager.go:781] "Started controller" controller="garbage-collector-controller" I0330 21:08:40.819713 1 controllermanager.go:781] "Started controller" controller="job-controller" I0330 21:08:40.819795 1 job_controller.go:257] "Starting job controller" logger="job-controller" I0330 21:08:40.819810 1 shared_informer.go:349] "Waiting for caches to sync" controller="job" I0330 21:08:41.036878 1 controllermanager.go:781] "Started controller" controller="deployment-controller" I0330 21:08:41.037171 1 deployment_controller.go:173] "Starting controller" logger="deployment-controller" controller="deployment" I0330 21:08:41.037193 1 shared_informer.go:349] "Waiting for caches to sync" controller="deployment" I0330 21:08:41.266727 1 controllermanager.go:781] "Started controller" controller="horizontal-pod-autoscaler-controller" I0330 21:08:41.266758 1 controllermanager.go:739] "Skipping a cloud provider controller" controller="node-route-controller" I0330 21:08:41.266807 1 horizontal.go:205] "Starting HPA controller" logger="horizontal-pod-autoscaler-controller" I0330 21:08:41.266828 1 shared_informer.go:349] "Waiting for caches to sync" controller="HPA" I0330 21:08:41.468758 1 controllermanager.go:781] "Started controller" controller="clusterrole-aggregation-controller" I0330 21:08:41.468925 1 clusterroleaggregation_controller.go:194] "Starting ClusterRoleAggregator controller" logger="clusterrole-aggregation-controller" I0330 21:08:41.468955 1 shared_informer.go:349] "Waiting for caches to sync" controller="ClusterRoleAggregator" I0330 21:08:41.651531 1 controllermanager.go:781] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0330 21:08:41.651672 1 cleaner.go:83] "Starting CSR cleaner controller" logger="certificatesigningrequest-cleaner-controller" I0330 21:08:41.720300 1 controllermanager.go:781] "Started controller" controller="persistentvolumeclaim-protection-controller" I0330 21:08:41.720383 1 pvc_protection_controller.go:168] "Starting PVC protection controller" logger="persistentvolumeclaim-protection-controller" I0330 21:08:41.720397 1 shared_informer.go:349] "Waiting for caches to sync" controller="PVC protection" I0330 21:08:41.869431 1 controllermanager.go:781] "Started controller" controller="resourceclaim-controller" I0330 21:08:41.869495 1 controller.go:397] "Starting resource claim controller" logger="resourceclaim-controller" I0330 21:08:41.869531 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource_claim" I0330 21:08:42.018794 1 controllermanager.go:781] "Started controller" controller="legacy-serviceaccount-token-cleaner-controller" I0330 21:08:42.018822 1 controllermanager.go:744] "Warning: controller is disabled" controller="selinux-warning-controller" I0330 21:08:42.018866 1 legacy_serviceaccount_token_cleaner.go:103] "Starting legacy service account token cleaner controller" logger="legacy-serviceaccount-token-cleaner-controller" I0330 21:08:42.018878 1 shared_informer.go:349] "Waiting for caches to sync" controller="legacy-service-account-token-cleaner" I0330 21:08:42.221643 1 controllermanager.go:781] "Started controller" controller="endpointslice-mirroring-controller" I0330 21:08:42.222451 1 endpointslicemirroring_controller.go:227] "Starting EndpointSliceMirroring controller" logger="endpointslice-mirroring-controller" I0330 21:08:42.222464 1 shared_informer.go:349] "Waiting for caches to sync" controller="endpoint_slice_mirroring" I0330 21:08:42.330239 1 controllermanager.go:781] "Started controller" controller="pod-garbage-collector-controller" I0330 21:08:42.330282 1 gc_controller.go:99] "Starting GC controller" logger="pod-garbage-collector-controller" I0330 21:08:42.330288 1 shared_informer.go:349] "Waiting for caches to sync" controller="GC" I0330 21:08:42.367781 1 controllermanager.go:781] "Started controller" controller="certificatesigningrequest-approving-controller" I0330 21:08:42.367815 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="podcertificaterequest-cleaner-controller" requiredFeatureGates=["PodCertificateRequest"] I0330 21:08:42.367846 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-approving-controller" name="csrapproving" I0330 21:08:42.367866 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrapproving" I0330 21:08:42.519309 1 controllermanager.go:781] "Started controller" controller="persistentvolume-attach-detach-controller" I0330 21:08:42.519470 1 attach_detach_controller.go:336] "Starting attach detach controller" logger="persistentvolume-attach-detach-controller" I0330 21:08:42.519499 1 shared_informer.go:349] "Waiting for caches to sync" controller="attach detach" I0330 21:08:42.671183 1 controllermanager.go:781] "Started controller" controller="ttl-after-finished-controller" I0330 21:08:42.671259 1 ttlafterfinished_controller.go:112] "Starting TTL after finished controller" logger="ttl-after-finished-controller" I0330 21:08:42.671268 1 shared_informer.go:349] "Waiting for caches to sync" controller="TTL after finished" I0330 21:08:42.820979 1 controllermanager.go:781] "Started controller" controller="service-cidr-controller" I0330 21:08:42.821264 1 servicecidrs_controller.go:137] "Starting" logger="service-cidr-controller" controller="service-cidr-controller" I0330 21:08:42.821293 1 shared_informer.go:349] "Waiting for caches to sync" controller="service-cidr-controller" I0330 21:08:43.026794 1 controllermanager.go:781] "Started controller" controller="endpoints-controller" I0330 21:08:43.026948 1 endpoints_controller.go:188] "Starting endpoint controller" logger="endpoints-controller" I0330 21:08:43.026976 1 shared_informer.go:349] "Waiting for caches to sync" controller="endpoint" I0330 21:08:43.394283 1 controllermanager.go:781] "Started controller" controller="daemonset-controller" I0330 21:08:43.394609 1 daemon_controller.go:310] "Starting daemon sets controller" logger="daemonset-controller" I0330 21:08:43.394777 1 shared_informer.go:349] "Waiting for caches to sync" controller="daemon sets" I0330 21:08:43.416550 1 controllermanager.go:781] "Started controller" controller="token-cleaner-controller" I0330 21:08:43.416567 1 controllermanager.go:739] "Skipping a cloud provider controller" controller="service-lb-controller" I0330 21:08:43.416573 1 controllermanager.go:739] "Skipping a cloud provider controller" controller="cloud-node-lifecycle-controller" I0330 21:08:43.416709 1 tokencleaner.go:117] "Starting token cleaner controller" logger="token-cleaner-controller" I0330 21:08:43.416720 1 shared_informer.go:349] "Waiting for caches to sync" controller="token_cleaner" I0330 21:08:43.416727 1 shared_informer.go:356] "Caches are synced" controller="token_cleaner" I0330 21:08:43.424561 1 controllermanager.go:781] "Started controller" controller="ephemeral-volume-controller" I0330 21:08:43.424632 1 controller.go:173] "Starting ephemeral volume controller" logger="ephemeral-volume-controller" I0330 21:08:43.424655 1 shared_informer.go:349] "Waiting for caches to sync" controller="ephemeral" I0330 21:08:43.727605 1 shared_informer.go:682] "Warning: resync period is smaller than resync check period and the informer has already started. Changing it to the resync check period" resyncPeriod="19h24m5.721479975s" resyncCheckPeriod="19h52m38.839452698s" I0330 21:08:43.727727 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="serviceaccounts" I0330 21:08:43.727763 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpoints" I0330 21:08:43.727900 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="poddisruptionbudgets.policy" I0330 21:08:43.727933 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpointslices.discovery.k8s.io" I0330 21:08:43.727959 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="csistoragecapacities.storage.k8s.io" I0330 21:08:43.727987 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="rolebindings.rbac.authorization.k8s.io" I0330 21:08:43.728070 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="podtemplates" I0330 21:08:43.728149 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="daemonsets.apps" I0330 21:08:43.728195 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="roles.rbac.authorization.k8s.io" I0330 21:08:43.728259 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="replicasets.apps" I0330 21:08:43.728299 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="horizontalpodautoscalers.autoscaling" I0330 21:08:43.728346 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="cronjobs.batch" I0330 21:08:43.728391 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="resourceclaimtemplates.resource.k8s.io" I0330 21:08:43.728413 1 shared_informer.go:682] "Warning: resync period is smaller than resync check period and the informer has already started. Changing it to the resync check period" resyncPeriod="13h21m36.841819745s" resyncCheckPeriod="19h52m38.839452698s" I0330 21:08:43.728490 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="controllerrevisions.apps" I0330 21:08:43.728550 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="limitranges" I0330 21:08:43.728575 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="deployments.apps" I0330 21:08:43.728601 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ingresses.networking.k8s.io" I0330 21:08:43.728632 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="networkpolicies.networking.k8s.io" I0330 21:08:43.728661 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="leases.coordination.k8s.io" I0330 21:08:43.728710 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="statefulsets.apps" I0330 21:08:43.728744 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="jobs.batch" I0330 21:08:43.728815 1 controllermanager.go:781] "Started controller" controller="resourcequota-controller" I0330 21:08:43.728940 1 resource_quota_controller.go:300] "Starting resource quota controller" logger="resourcequota-controller" I0330 21:08:43.728973 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0330 21:08:43.729051 1 resource_quota_monitor.go:308] "QuotaMonitor running" logger="resourcequota-controller" I0330 21:08:43.975877 1 controllermanager.go:781] "Started controller" controller="namespace-controller" I0330 21:08:43.975905 1 namespace_controller.go:202] "Starting namespace controller" logger="namespace-controller" I0330 21:08:43.975926 1 shared_informer.go:349] "Waiting for caches to sync" controller="namespace" I0330 21:08:44.123305 1 controllermanager.go:781] "Started controller" controller="replicaset-controller" I0330 21:08:44.123647 1 replica_set.go:243] "Starting controller" logger="replicaset-controller" name="replicaset" I0330 21:08:44.123669 1 shared_informer.go:349] "Waiting for caches to sync" controller="ReplicaSet" I0330 21:08:44.319314 1 controllermanager.go:781] "Started controller" controller="disruption-controller" I0330 21:08:44.319378 1 disruption.go:457] "Sending events to api server." logger="disruption-controller" I0330 21:08:44.319489 1 disruption.go:468] "Starting disruption controller" logger="disruption-controller" I0330 21:08:44.319516 1 shared_informer.go:349] "Waiting for caches to sync" controller="disruption" I0330 21:08:44.468168 1 controllermanager.go:781] "Started controller" controller="cronjob-controller" I0330 21:08:44.468289 1 cronjob_controllerv2.go:145] "Starting cronjob controller v2" logger="cronjob-controller" I0330 21:08:44.468300 1 shared_informer.go:349] "Waiting for caches to sync" controller="cronjob" I0330 21:08:44.519064 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-serving" I0330 21:08:44.519102 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-kubelet-serving" I0330 21:08:44.519136 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0330 21:08:44.520033 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-client" I0330 21:08:44.520061 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-kubelet-client" I0330 21:08:44.520091 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0330 21:08:44.521041 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kube-apiserver-client" I0330 21:08:44.521087 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0330 21:08:44.521111 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-kube-apiserver-client" I0330 21:08:44.522228 1 controllermanager.go:781] "Started controller" controller="certificatesigningrequest-signing-controller" I0330 21:08:44.522335 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-legacy-unknown" I0330 21:08:44.522365 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-legacy-unknown" I0330 21:08:44.522425 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0330 21:08:44.532942 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0330 21:08:44.545424 1 actual_state_of_world.go:541] "Failed to update statusUpdateNeeded field in actual state of world" logger="persistentvolume-attach-detach-controller" err="Failed to set statusUpdateNeeded to needed true, because nodeName=\"controller\" does not exist" I0330 21:08:44.548315 1 shared_informer.go:356] "Caches are synced" controller="bootstrap_signer" I0330 21:08:44.555361 1 shared_informer.go:356] "Caches are synced" controller="VAC protection" I0330 21:08:44.555593 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0330 21:08:44.565096 1 shared_informer.go:356] "Caches are synced" controller="ReplicationController" I0330 21:08:44.566713 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0330 21:08:44.566728 1 garbagecollector.go:154] "Garbage collector: all resource monitors have synced" logger="garbage-collector-controller" I0330 21:08:44.566735 1 garbagecollector.go:157] "Proceeding to collect garbage" logger="garbage-collector-controller" I0330 21:08:44.567413 1 shared_informer.go:356] "Caches are synced" controller="HPA" I0330 21:08:44.567900 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrapproving" I0330 21:08:44.568603 1 shared_informer.go:356] "Caches are synced" controller="taint-eviction-controller" I0330 21:08:44.568737 1 shared_informer.go:356] "Caches are synced" controller="cronjob" I0330 21:08:44.569151 1 shared_informer.go:356] "Caches are synced" controller="ClusterRoleAggregator" I0330 21:08:44.569683 1 shared_informer.go:356] "Caches are synced" controller="resource_claim" I0330 21:08:44.571744 1 shared_informer.go:356] "Caches are synced" controller="service account" I0330 21:08:44.571853 1 shared_informer.go:356] "Caches are synced" controller="TTL after finished" I0330 21:08:44.576033 1 shared_informer.go:356] "Caches are synced" controller="namespace" I0330 21:08:44.580240 1 shared_informer.go:356] "Caches are synced" controller="TTL" I0330 21:08:44.587460 1 shared_informer.go:356] "Caches are synced" controller="PV protection" I0330 21:08:44.593692 1 shared_informer.go:356] "Caches are synced" controller="crt configmap" I0330 21:08:44.595957 1 shared_informer.go:356] "Caches are synced" controller="daemon sets" I0330 21:08:44.618408 1 shared_informer.go:356] "Caches are synced" controller="validatingadmissionpolicy-status" I0330 21:08:44.619860 1 shared_informer.go:356] "Caches are synced" controller="disruption" I0330 21:08:44.619894 1 shared_informer.go:356] "Caches are synced" controller="job" I0330 21:08:44.619909 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-kubelet-serving" I0330 21:08:44.619990 1 shared_informer.go:356] "Caches are synced" controller="endpoint_slice" I0330 21:08:44.620047 1 shared_informer.go:356] "Caches are synced" controller="legacy-service-account-token-cleaner" I0330 21:08:44.619927 1 shared_informer.go:356] "Caches are synced" controller="attach detach" I0330 21:08:44.620154 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-kubelet-client" I0330 21:08:44.620449 1 shared_informer.go:356] "Caches are synced" controller="PVC protection" I0330 21:08:44.620759 1 shared_informer.go:356] "Caches are synced" controller="persistent volume" I0330 21:08:44.621530 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-kube-apiserver-client" I0330 21:08:44.621553 1 shared_informer.go:356] "Caches are synced" controller="service-cidr-controller" I0330 21:08:44.622735 1 shared_informer.go:356] "Caches are synced" controller="endpoint_slice_mirroring" I0330 21:08:44.622765 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-legacy-unknown" I0330 21:08:44.624007 1 shared_informer.go:356] "Caches are synced" controller="ReplicaSet" I0330 21:08:44.624864 1 shared_informer.go:356] "Caches are synced" controller="ephemeral" I0330 21:08:44.627265 1 shared_informer.go:356] "Caches are synced" controller="endpoint" I0330 21:08:44.627434 1 shared_informer.go:356] "Caches are synced" controller="taint" I0330 21:08:44.627729 1 node_lifecycle_controller.go:1221] "Initializing eviction metric for zone" logger="node-lifecycle-controller" zone="" I0330 21:08:44.627883 1 node_lifecycle_controller.go:873] "Missing timestamp for Node. Assuming now as a timestamp" logger="node-lifecycle-controller" node="controller" I0330 21:08:44.628042 1 node_lifecycle_controller.go:1025] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" logger="node-lifecycle-controller" I0330 21:08:44.630053 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0330 21:08:44.631300 1 shared_informer.go:356] "Caches are synced" controller="GC" I0330 21:08:44.633674 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0330 21:08:44.633693 1 shared_informer.go:356] "Caches are synced" controller="expand" I0330 21:08:44.637970 1 shared_informer.go:356] "Caches are synced" controller="deployment" I0330 21:08:44.642329 1 shared_informer.go:356] "Caches are synced" controller="stateful set" I0330 21:08:44.656701 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0330 21:09:34.636738 1 node_lifecycle_controller.go:1044] "Controller detected that some Nodes are Ready. Exiting master disruption mode" logger="node-lifecycle-controller" I0330 21:09:44.650260 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backends.gateway.envoyproxy.io" I0330 21:09:44.650360 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="udproutes.gateway.networking.k8s.io" I0330 21:09:44.650542 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumendpoints.cilium.io" I0330 21:09:44.650587 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnodeconfigs.cilium.io" I0330 21:09:44.650665 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0330 21:09:44.650765 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0330 21:09:44.650806 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyproxies.gateway.envoyproxy.io" I0330 21:09:44.650901 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutefilters.gateway.envoyproxy.io" I0330 21:09:44.651000 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="gateways.gateway.networking.k8s.io" I0330 21:09:44.651097 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutes.gateway.networking.k8s.io" I0330 21:09:44.651194 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnetworkpolicies.cilium.io" I0330 21:09:44.651657 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtlspolicies.gateway.networking.k8s.io" I0330 21:09:44.651770 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="grpcroutes.gateway.networking.k8s.io" I0330 21:09:44.651880 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0330 21:09:44.651987 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoypatchpolicies.gateway.envoyproxy.io" I0330 21:09:44.652088 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0330 21:09:44.652182 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tlsroutes.gateway.networking.k8s.io" I0330 21:09:44.652298 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xlistenersets.gateway.networking.x-k8s.io" I0330 21:09:44.652426 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="securitypolicies.gateway.envoyproxy.io" I0330 21:09:44.652535 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="referencegrants.gateway.networking.k8s.io" I0330 21:09:44.652640 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tcproutes.gateway.networking.k8s.io" I0330 21:09:44.653130 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0330 21:09:44.682779 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0330 21:09:46.953780 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0330 21:09:46.983528 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0330 21:10:16.962115 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="challenges.acme.cert-manager.io" I0330 21:10:16.962182 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="orders.acme.cert-manager.io" I0330 21:10:16.962222 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="issuers.cert-manager.io" I0330 21:10:16.962278 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="certificaterequests.cert-manager.io" I0330 21:10:16.962377 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="certificates.cert-manager.io" I0330 21:10:16.962518 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0330 21:10:16.996691 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0330 21:10:17.063012 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0330 21:10:17.097706 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0330 21:10:33.854856 1 namespace_controller.go:187] "Namespace has been deleted" logger="namespace-controller" namespace="cert-manager-test" I0330 21:10:47.071936 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackmachinetemplates.infrastructure.cluster.x-k8s.io" I0330 21:10:47.072005 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusters.cluster.x-k8s.io" I0330 21:10:47.072025 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="providers.clusterctl.cluster.x-k8s.io" I0330 21:10:47.072055 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackclustertemplates.infrastructure.cluster.x-k8s.io" I0330 21:10:47.072072 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackclusters.infrastructure.cluster.x-k8s.io" I0330 21:10:47.072084 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinehealthchecks.cluster.x-k8s.io" I0330 21:10:47.072101 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ipaddressclaims.ipam.cluster.x-k8s.io" I0330 21:10:47.072124 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusterresourcesets.addons.cluster.x-k8s.io" I0330 21:10:47.072137 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmconfigs.bootstrap.cluster.x-k8s.io" I0330 21:10:47.072157 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackservers.infrastructure.cluster.x-k8s.io" I0330 21:10:47.072172 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmconfigtemplates.bootstrap.cluster.x-k8s.io" I0330 21:10:47.072315 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machines.cluster.x-k8s.io" I0330 21:10:47.072334 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusterresourcesetbindings.addons.cluster.x-k8s.io" I0330 21:10:47.072347 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinesets.cluster.x-k8s.io" I0330 21:10:47.072360 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ipaddresses.ipam.cluster.x-k8s.io" I0330 21:10:47.072540 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinepools.cluster.x-k8s.io" I0330 21:10:47.072562 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmcontrolplanes.controlplane.cluster.x-k8s.io" I0330 21:10:47.072646 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackmachines.infrastructure.cluster.x-k8s.io" I0330 21:10:47.072810 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackfloatingippools.infrastructure.cluster.x-k8s.io" I0330 21:10:47.072839 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmcontrolplanetemplates.controlplane.cluster.x-k8s.io" I0330 21:10:47.072853 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="images.openstack.k-orc.cloud" I0330 21:10:47.072867 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinedeployments.cluster.x-k8s.io" I0330 21:10:47.072885 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusterclasses.cluster.x-k8s.io" I0330 21:10:47.073132 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0330 21:10:47.124023 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0330 21:10:47.174213 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0330 21:10:47.224656 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" E0330 21:11:40.981002 1 garbagecollector.go:360] "Unhandled Error" err="error syncing item &garbagecollector.node{identity:garbagecollector.objectReference{OwnerReference:v1.OwnerReference{APIVersion:\"cert-manager.io/v1\", Kind:\"CertificateRequest\", Name:\"capi-serving-cert-1\", UID:\"40c48a9c-d23d-4c54-abc1-1eb8ae35cb24\", Controller:(*bool)(nil), BlockOwnerDeletion:(*bool)(nil)}, Namespace:\"capi-system\"}, dependentsLock:sync.RWMutex{w:sync.Mutex{_:sync.noCopy{}, mu:sync.Mutex{state:0, sema:0x0}}, writerSem:0x0, readerSem:0x0, readerCount:atomic.Int32{_:atomic.noCopy{}, v:1}, readerWait:atomic.Int32{_:atomic.noCopy{}, v:0}}, dependents:map[*garbagecollector.node]struct {}{}, deletingDependents:false, deletingDependentsLock:sync.RWMutex{w:sync.Mutex{_:sync.noCopy{}, mu:sync.Mutex{state:0, sema:0x0}}, writerSem:0x0, readerSem:0x0, readerCount:atomic.Int32{_:atomic.noCopy{}, v:0}, readerWait:atomic.Int32{_:atomic.noCopy{}, v:0}}, beingDeleted:false, beingDeletedLock:sync.RWMutex{w:sync.Mutex{_:sync.noCopy{}, mu:sync.Mutex{state:0, sema:0x0}}, writerSem:0x0, readerSem:0x0, readerCount:atomic.Int32{_:atomic.noCopy{}, v:0}, readerWait:atomic.Int32{_:atomic.noCopy{}, v:0}}, virtual:false, virtualLock:sync.RWMutex{w:sync.Mutex{_:sync.noCopy{}, mu:sync.Mutex{state:0, sema:0x0}}, writerSem:0x0, readerSem:0x0, readerCount:atomic.Int32{_:atomic.noCopy{}, v:0}, readerWait:atomic.Int32{_:atomic.noCopy{}, v:0}}, owners:[]v1.OwnerReference{v1.OwnerReference{APIVersion:\"cert-manager.io/v1\", Kind:\"Certificate\", Name:\"capi-serving-cert\", UID:\"beceaa40-261d-4168-9cc9-ef90db357dbf\", Controller:(*bool)(0xc0029f17bb), BlockOwnerDeletion:(*bool)(0xc0029f17bc)}}}: certificaterequests.cert-manager.io \"capi-serving-cert-1\" not found" logger="UnhandledError" I0330 21:11:47.193706 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="domains.openstack.k-orc.cloud" I0330 21:11:47.193750 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="servers.openstack.k-orc.cloud" I0330 21:11:47.193764 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="services.openstack.k-orc.cloud" I0330 21:11:47.193777 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="keypairs.openstack.k-orc.cloud" I0330 21:11:47.193794 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="routerinterfaces.openstack.k-orc.cloud" I0330 21:11:47.193818 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="servergroups.openstack.k-orc.cloud" I0330 21:11:47.193845 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="volumetypes.openstack.k-orc.cloud" I0330 21:11:47.193868 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="networks.openstack.k-orc.cloud" I0330 21:11:47.193900 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="securitygroups.openstack.k-orc.cloud" I0330 21:11:47.193935 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="projects.openstack.k-orc.cloud" I0330 21:11:47.193950 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ports.openstack.k-orc.cloud" I0330 21:11:47.193965 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="volumes.openstack.k-orc.cloud" I0330 21:11:47.193988 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="routers.openstack.k-orc.cloud" I0330 21:11:47.194015 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="groups.openstack.k-orc.cloud" I0330 21:11:47.194033 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="floatingips.openstack.k-orc.cloud" I0330 21:11:47.194051 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinedrainrules.cluster.x-k8s.io" I0330 21:11:47.194074 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="roles.openstack.k-orc.cloud" I0330 21:11:47.194093 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="subnets.openstack.k-orc.cloud" I0330 21:11:47.194106 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="flavors.openstack.k-orc.cloud" I0330 21:11:47.201056 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0330 21:11:47.247667 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0330 21:11:48.248749 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0330 21:11:48.301774 1 shared_informer.go:356] "Caches are synced" controller="resource quota"