I0731 00:53:01.795537 1 serving.go:386] Generated self-signed cert in-memory I0731 00:53:02.179278 1 controllermanager.go:191] "Starting" version="v1.34.0" I0731 00:53:02.179339 1 controllermanager.go:193] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0731 00:53:02.180817 1 dynamic_cafile_content.go:161] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0731 00:53:02.180817 1 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0731 00:53:02.181089 1 secure_serving.go:211] Serving securely on [::]:10257 I0731 00:53:02.181345 1 tlsconfig.go:243] "Starting DynamicServingCertificateController" I0731 00:53:02.181587 1 leaderelection.go:257] attempting to acquire leader lease kube-system/kube-controller-manager... E0731 00:53:03.260425 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" I0731 00:53:05.579695 1 leaderelection.go:271] successfully acquired lease kube-system/kube-controller-manager I0731 00:53:05.579788 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_edc94d0c-74b0-45d6-8bb6-de2cd5f2e68d became leader" I0731 00:53:05.584622 1 controllermanager.go:781] "Started controller" controller="serviceaccount-token-controller" I0731 00:53:05.584854 1 shared_informer.go:349] "Waiting for caches to sync" controller="tokens" I0731 00:53:05.619061 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="deployments.apps" I0731 00:53:05.619209 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="jobs.batch" I0731 00:53:05.619243 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="limitranges" I0731 00:53:05.619421 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="statefulsets.apps" I0731 00:53:05.619456 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="controllerrevisions.apps" I0731 00:53:05.619607 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="horizontalpodautoscalers.autoscaling" I0731 00:53:05.619792 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="networkpolicies.networking.k8s.io" I0731 00:53:05.619974 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="rolebindings.rbac.authorization.k8s.io" I0731 00:53:05.620121 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="leases.coordination.k8s.io" I0731 00:53:05.620354 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="poddisruptionbudgets.policy" I0731 00:53:05.620540 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="daemonsets.apps" I0731 00:53:05.620692 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="13h27m14.920114872s" resyncCheckPeriod="23h49m11.123479159s" I0731 00:53:05.620866 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="csistoragecapacities.storage.k8s.io" I0731 00:53:05.620922 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="podtemplates" I0731 00:53:05.620997 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="replicasets.apps" I0731 00:53:05.621056 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="cronjobs.batch" I0731 00:53:05.621083 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="resourceclaimtemplates.resource.k8s.io" I0731 00:53:05.621244 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="roles.rbac.authorization.k8s.io" I0731 00:53:05.621357 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpointslices.discovery.k8s.io" I0731 00:53:05.621518 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpoints" I0731 00:53:05.621537 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="18h24m32.607662089s" resyncCheckPeriod="23h49m11.123479159s" I0731 00:53:05.621642 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="serviceaccounts" I0731 00:53:05.621715 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ingresses.networking.k8s.io" I0731 00:53:05.621746 1 controllermanager.go:781] "Started controller" controller="resourcequota-controller" I0731 00:53:05.621827 1 resource_quota_controller.go:300] "Starting resource quota controller" logger="resourcequota-controller" I0731 00:53:05.621867 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:53:05.621936 1 resource_quota_monitor.go:308] "QuotaMonitor running" logger="resourcequota-controller" I0731 00:53:05.632958 1 garbagecollector.go:144] "Starting controller" logger="garbage-collector-controller" controller="garbagecollector" I0731 00:53:05.632974 1 controllermanager.go:781] "Started controller" controller="garbage-collector-controller" I0731 00:53:05.632985 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:53:05.633029 1 graph_builder.go:351] "Running" logger="garbage-collector-controller" component="GraphBuilder" I0731 00:53:05.647374 1 controllermanager.go:781] "Started controller" controller="disruption-controller" I0731 00:53:05.647468 1 disruption.go:457] "Sending events to api server." logger="disruption-controller" I0731 00:53:05.647622 1 disruption.go:468] "Starting disruption controller" logger="disruption-controller" I0731 00:53:05.647689 1 shared_informer.go:349] "Waiting for caches to sync" controller="disruption" I0731 00:53:05.655785 1 controllermanager.go:781] "Started controller" controller="ttl-controller" I0731 00:53:05.655949 1 ttl_controller.go:127] "Starting TTL controller" logger="ttl-controller" I0731 00:53:05.655962 1 shared_informer.go:349] "Waiting for caches to sync" controller="TTL" I0731 00:53:05.663615 1 controllermanager.go:781] "Started controller" controller="bootstrap-signer-controller" I0731 00:53:05.663653 1 shared_informer.go:349] "Waiting for caches to sync" controller="bootstrap_signer" I0731 00:53:05.671926 1 controllermanager.go:781] "Started controller" controller="resourceclaim-controller" I0731 00:53:05.672065 1 controllermanager.go:744] "Warning: controller is disabled" controller="selinux-warning-controller" I0731 00:53:05.671961 1 controller.go:397] "Starting resource claim controller" logger="resourceclaim-controller" I0731 00:53:05.672428 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource_claim" I0731 00:53:05.681497 1 controllermanager.go:781] "Started controller" controller="endpointslice-controller" I0731 00:53:05.681610 1 endpointslice_controller.go:281] "Starting endpoint slice controller" logger="endpointslice-controller" I0731 00:53:05.681626 1 shared_informer.go:349] "Waiting for caches to sync" controller="endpoint_slice" I0731 00:53:05.685737 1 shared_informer.go:356] "Caches are synced" controller="tokens" I0731 00:53:05.737845 1 controllermanager.go:781] "Started controller" controller="pod-garbage-collector-controller" I0731 00:53:05.737948 1 gc_controller.go:99] "Starting GC controller" logger="pod-garbage-collector-controller" I0731 00:53:05.737983 1 shared_informer.go:349] "Waiting for caches to sync" controller="GC" I0731 00:53:05.887499 1 controllermanager.go:781] "Started controller" controller="deployment-controller" I0731 00:53:05.887819 1 deployment_controller.go:173] "Starting controller" logger="deployment-controller" controller="deployment" I0731 00:53:05.887891 1 shared_informer.go:349] "Waiting for caches to sync" controller="deployment" I0731 00:53:06.040750 1 controllermanager.go:781] "Started controller" controller="statefulset-controller" I0731 00:53:06.040782 1 controllermanager.go:739] "Skipping a cloud provider controller" controller="node-route-controller" I0731 00:53:06.040789 1 controllermanager.go:739] "Skipping a cloud provider controller" controller="cloud-node-lifecycle-controller" I0731 00:53:06.040981 1 stateful_set.go:169] "Starting stateful set controller" logger="statefulset-controller" I0731 00:53:06.041013 1 shared_informer.go:349] "Waiting for caches to sync" controller="stateful set" I0731 00:53:06.186213 1 controllermanager.go:781] "Started controller" controller="ephemeral-volume-controller" I0731 00:53:06.186418 1 controller.go:173] "Starting ephemeral volume controller" logger="ephemeral-volume-controller" I0731 00:53:06.186453 1 shared_informer.go:349] "Waiting for caches to sync" controller="ephemeral" I0731 00:53:06.485021 1 controllermanager.go:781] "Started controller" controller="horizontal-pod-autoscaler-controller" I0731 00:53:06.485058 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="podcertificaterequest-cleaner-controller" requiredFeatureGates=["PodCertificateRequest"] I0731 00:53:06.485091 1 horizontal.go:205] "Starting HPA controller" logger="horizontal-pod-autoscaler-controller" I0731 00:53:06.485244 1 shared_informer.go:349] "Waiting for caches to sync" controller="HPA" I0731 00:53:06.485101 1 controllermanager.go:739] "Skipping a cloud provider controller" controller="service-lb-controller" I0731 00:53:06.927291 1 controllermanager.go:781] "Started controller" controller="persistentvolume-attach-detach-controller" I0731 00:53:06.927491 1 attach_detach_controller.go:336] "Starting attach detach controller" logger="persistentvolume-attach-detach-controller" I0731 00:53:06.927529 1 shared_informer.go:349] "Waiting for caches to sync" controller="attach detach" I0731 00:53:06.954890 1 controllermanager.go:781] "Started controller" controller="persistentvolume-expander-controller" I0731 00:53:06.955015 1 expand_controller.go:327] "Starting expand controller" logger="persistentvolume-expander-controller" I0731 00:53:06.955045 1 shared_informer.go:349] "Waiting for caches to sync" controller="expand" I0731 00:53:06.965621 1 controllermanager.go:781] "Started controller" controller="ttl-after-finished-controller" I0731 00:53:06.966034 1 ttlafterfinished_controller.go:112] "Starting TTL after finished controller" logger="ttl-after-finished-controller" I0731 00:53:06.966059 1 shared_informer.go:349] "Waiting for caches to sync" controller="TTL after finished" I0731 00:53:07.134015 1 controllermanager.go:781] "Started controller" controller="validatingadmissionpolicy-status-controller" I0731 00:53:07.134106 1 shared_informer.go:349] "Waiting for caches to sync" controller="validatingadmissionpolicy-status" I0731 00:53:07.288244 1 controllermanager.go:781] "Started controller" controller="endpointslice-mirroring-controller" I0731 00:53:07.288374 1 endpointslicemirroring_controller.go:227] "Starting EndpointSliceMirroring controller" logger="endpointslice-mirroring-controller" I0731 00:53:07.288403 1 shared_informer.go:349] "Waiting for caches to sync" controller="endpoint_slice_mirroring" I0731 00:53:07.436206 1 controllermanager.go:781] "Started controller" controller="serviceaccount-controller" I0731 00:53:07.436335 1 serviceaccounts_controller.go:114] "Starting service account controller" logger="serviceaccount-controller" I0731 00:53:07.436358 1 shared_informer.go:349] "Waiting for caches to sync" controller="service account" I0731 00:53:07.588897 1 controllermanager.go:781] "Started controller" controller="job-controller" I0731 00:53:07.588965 1 job_controller.go:257] "Starting job controller" logger="job-controller" I0731 00:53:07.588990 1 shared_informer.go:349] "Waiting for caches to sync" controller="job" I0731 00:53:07.737691 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-serving" I0731 00:53:07.737738 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-kubelet-serving" I0731 00:53:07.737766 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0731 00:53:07.738612 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-client" I0731 00:53:07.738655 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-kubelet-client" I0731 00:53:07.738722 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0731 00:53:07.739653 1 controllermanager.go:781] "Started controller" controller="certificatesigningrequest-signing-controller" I0731 00:53:07.739736 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kube-apiserver-client" I0731 00:53:07.739870 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-kube-apiserver-client" I0731 00:53:07.739755 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0731 00:53:07.739778 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0731 00:53:07.739770 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-legacy-unknown" I0731 00:53:07.739978 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrsigning-legacy-unknown" I0731 00:53:07.888116 1 node_lifecycle_controller.go:419] "Controller will reconcile labels" logger="node-lifecycle-controller" I0731 00:53:07.888169 1 controllermanager.go:781] "Started controller" controller="node-lifecycle-controller" I0731 00:53:07.888235 1 node_lifecycle_controller.go:453] "Sending events to api server" logger="node-lifecycle-controller" I0731 00:53:07.888430 1 node_lifecycle_controller.go:464] "Starting node controller" logger="node-lifecycle-controller" I0731 00:53:07.888445 1 shared_informer.go:349] "Waiting for caches to sync" controller="taint" I0731 00:53:08.036638 1 controllermanager.go:781] "Started controller" controller="clusterrole-aggregation-controller" I0731 00:53:08.036707 1 clusterroleaggregation_controller.go:194] "Starting ClusterRoleAggregator controller" logger="clusterrole-aggregation-controller" I0731 00:53:08.036717 1 shared_informer.go:349] "Waiting for caches to sync" controller="ClusterRoleAggregator" I0731 00:53:08.186176 1 controllermanager.go:781] "Started controller" controller="service-cidr-controller" I0731 00:53:08.186371 1 servicecidrs_controller.go:137] "Starting" logger="service-cidr-controller" controller="service-cidr-controller" I0731 00:53:08.186394 1 shared_informer.go:349] "Waiting for caches to sync" controller="service-cidr-controller" I0731 00:53:08.337419 1 controllermanager.go:781] "Started controller" controller="endpoints-controller" I0731 00:53:08.337623 1 endpoints_controller.go:188] "Starting endpoint controller" logger="endpoints-controller" I0731 00:53:08.337650 1 shared_informer.go:349] "Waiting for caches to sync" controller="endpoint" I0731 00:53:08.487935 1 controllermanager.go:781] "Started controller" controller="replicationcontroller-controller" I0731 00:53:08.488137 1 replica_set.go:243] "Starting controller" logger="replicationcontroller-controller" name="replicationcontroller" I0731 00:53:08.488165 1 shared_informer.go:349] "Waiting for caches to sync" controller="ReplicationController" I0731 00:53:08.637458 1 controllermanager.go:781] "Started controller" controller="daemonset-controller" I0731 00:53:08.637571 1 daemon_controller.go:310] "Starting daemon sets controller" logger="daemonset-controller" I0731 00:53:08.637586 1 shared_informer.go:349] "Waiting for caches to sync" controller="daemon sets" I0731 00:53:08.786690 1 controllermanager.go:781] "Started controller" controller="cronjob-controller" I0731 00:53:08.786837 1 cronjob_controllerv2.go:145] "Starting cronjob controller v2" logger="cronjob-controller" I0731 00:53:08.786859 1 shared_informer.go:349] "Waiting for caches to sync" controller="cronjob" I0731 00:53:08.937649 1 controllermanager.go:781] "Started controller" controller="persistentvolume-binder-controller" I0731 00:53:08.937892 1 pv_controller_base.go:308] "Starting persistent volume controller" logger="persistentvolume-binder-controller" I0731 00:53:08.937929 1 shared_informer.go:349] "Waiting for caches to sync" controller="persistent volume" I0731 00:53:09.086685 1 controllermanager.go:781] "Started controller" controller="persistentvolume-protection-controller" I0731 00:53:09.086728 1 pv_protection_controller.go:81] "Starting PV protection controller" logger="persistentvolume-protection-controller" I0731 00:53:09.086783 1 shared_informer.go:349] "Waiting for caches to sync" controller="PV protection" I0731 00:53:09.241056 1 publisher.go:107] "Starting root CA cert publisher controller" logger="root-ca-certificate-publisher-controller" I0731 00:53:09.241090 1 shared_informer.go:349] "Waiting for caches to sync" controller="crt configmap" I0731 00:53:09.241199 1 controllermanager.go:781] "Started controller" controller="root-ca-certificate-publisher-controller" I0731 00:53:09.386189 1 controllermanager.go:781] "Started controller" controller="legacy-serviceaccount-token-cleaner-controller" I0731 00:53:09.386454 1 legacy_serviceaccount_token_cleaner.go:103] "Starting legacy service account token cleaner controller" logger="legacy-serviceaccount-token-cleaner-controller" I0731 00:53:09.386519 1 shared_informer.go:349] "Waiting for caches to sync" controller="legacy-service-account-token-cleaner" I0731 00:53:09.434689 1 controllermanager.go:781] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0731 00:53:09.434759 1 cleaner.go:83] "Starting CSR cleaner controller" logger="certificatesigningrequest-cleaner-controller" I0731 00:53:09.585883 1 controllermanager.go:781] "Started controller" controller="token-cleaner-controller" I0731 00:53:09.585922 1 controllermanager.go:759] "Warning: skipping controller" controller="node-ipam-controller" I0731 00:53:09.585973 1 tokencleaner.go:117] "Starting token cleaner controller" logger="token-cleaner-controller" I0731 00:53:09.585985 1 shared_informer.go:349] "Waiting for caches to sync" controller="token_cleaner" I0731 00:53:09.585995 1 shared_informer.go:356] "Caches are synced" controller="token_cleaner" I0731 00:53:09.736200 1 controllermanager.go:781] "Started controller" controller="persistentvolumeclaim-protection-controller" I0731 00:53:09.736298 1 pvc_protection_controller.go:168] "Starting PVC protection controller" logger="persistentvolumeclaim-protection-controller" I0731 00:53:09.736313 1 shared_informer.go:349] "Waiting for caches to sync" controller="PVC protection" I0731 00:53:09.889449 1 controllermanager.go:781] "Started controller" controller="volumeattributesclass-protection-controller" I0731 00:53:09.889507 1 vac_protection_controller.go:206] "Starting VAC protection controller" logger="volumeattributesclass-protection-controller" I0731 00:53:09.889516 1 shared_informer.go:349] "Waiting for caches to sync" controller="VAC protection" I0731 00:53:09.935020 1 controllermanager.go:781] "Started controller" controller="taint-eviction-controller" I0731 00:53:09.935060 1 controllermanager.go:759] "Warning: skipping controller" controller="storage-version-migrator-controller" I0731 00:53:09.935332 1 taint_eviction.go:282] "Starting" logger="taint-eviction-controller" controller="taint-eviction-controller" I0731 00:53:09.935605 1 taint_eviction.go:288] "Sending events to api server" logger="taint-eviction-controller" I0731 00:53:09.935706 1 shared_informer.go:349] "Waiting for caches to sync" controller="taint-eviction-controller" I0731 00:53:10.088909 1 controllermanager.go:781] "Started controller" controller="replicaset-controller" I0731 00:53:10.089057 1 replica_set.go:243] "Starting controller" logger="replicaset-controller" name="replicaset" I0731 00:53:10.089087 1 shared_informer.go:349] "Waiting for caches to sync" controller="ReplicaSet" I0731 00:53:10.134781 1 controllermanager.go:781] "Started controller" controller="certificatesigningrequest-approving-controller" I0731 00:53:10.134805 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="kube-apiserver-serving-clustertrustbundle-publisher-controller" requiredFeatureGates=["ClusterTrustBundle"] I0731 00:53:10.134925 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-approving-controller" name="csrapproving" I0731 00:53:10.134970 1 shared_informer.go:349] "Waiting for caches to sync" controller="certificate-csrapproving" I0731 00:53:10.396112 1 controllermanager.go:781] "Started controller" controller="namespace-controller" I0731 00:53:10.396149 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="storageversion-garbage-collector-controller" requiredFeatureGates=["APIServerIdentity","StorageVersionAPI"] I0731 00:53:10.396168 1 controllermanager.go:733] "Controller is disabled by a feature gate" controller="device-taint-eviction-controller" requiredFeatureGates=["DynamicResourceAllocation","DRADeviceTaints"] I0731 00:53:10.396237 1 namespace_controller.go:202] "Starting namespace controller" logger="namespace-controller" I0731 00:53:10.396271 1 shared_informer.go:349] "Waiting for caches to sync" controller="namespace" I0731 00:53:10.404176 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:53:10.416810 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" I0731 00:53:10.419524 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:53:10.422229 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:53:10.427726 1 shared_informer.go:356] "Caches are synced" controller="attach detach" I0731 00:53:10.434015 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0731 00:53:10.434036 1 garbagecollector.go:154] "Garbage collector: all resource monitors have synced" logger="garbage-collector-controller" I0731 00:53:10.434043 1 garbagecollector.go:157] "Proceeding to collect garbage" logger="garbage-collector-controller" I0731 00:53:10.434168 1 shared_informer.go:356] "Caches are synced" controller="validatingadmissionpolicy-status" I0731 00:53:10.436158 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrapproving" I0731 00:53:10.436343 1 shared_informer.go:356] "Caches are synced" controller="taint-eviction-controller" I0731 00:53:10.436412 1 shared_informer.go:356] "Caches are synced" controller="PVC protection" I0731 00:53:10.436473 1 shared_informer.go:356] "Caches are synced" controller="service account" I0731 00:53:10.436874 1 shared_informer.go:356] "Caches are synced" controller="ClusterRoleAggregator" I0731 00:53:10.437621 1 shared_informer.go:356] "Caches are synced" controller="daemon sets" I0731 00:53:10.437739 1 shared_informer.go:356] "Caches are synced" controller="endpoint" I0731 00:53:10.437828 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-kubelet-serving" I0731 00:53:10.438682 1 shared_informer.go:356] "Caches are synced" controller="GC" I0731 00:53:10.438697 1 shared_informer.go:356] "Caches are synced" controller="persistent volume" I0731 00:53:10.438763 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-kubelet-client" I0731 00:53:10.441090 1 shared_informer.go:356] "Caches are synced" controller="stateful set" I0731 00:53:10.441132 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-kube-apiserver-client" I0731 00:53:10.441350 1 shared_informer.go:356] "Caches are synced" controller="crt configmap" I0731 00:53:10.441436 1 shared_informer.go:356] "Caches are synced" controller="certificate-csrsigning-legacy-unknown" I0731 00:53:10.448693 1 shared_informer.go:356] "Caches are synced" controller="disruption" I0731 00:53:10.455974 1 shared_informer.go:356] "Caches are synced" controller="expand" I0731 00:53:10.456280 1 shared_informer.go:356] "Caches are synced" controller="TTL" I0731 00:53:10.464256 1 shared_informer.go:356] "Caches are synced" controller="bootstrap_signer" I0731 00:53:10.466605 1 shared_informer.go:356] "Caches are synced" controller="TTL after finished" I0731 00:53:10.473003 1 shared_informer.go:356] "Caches are synced" controller="resource_claim" I0731 00:53:10.481709 1 shared_informer.go:356] "Caches are synced" controller="endpoint_slice" I0731 00:53:10.485331 1 shared_informer.go:356] "Caches are synced" controller="HPA" I0731 00:53:10.486520 1 shared_informer.go:356] "Caches are synced" controller="ephemeral" I0731 00:53:10.486757 1 shared_informer.go:356] "Caches are synced" controller="legacy-service-account-token-cleaner" I0731 00:53:10.486716 1 shared_informer.go:356] "Caches are synced" controller="service-cidr-controller" I0731 00:53:10.486824 1 shared_informer.go:356] "Caches are synced" controller="PV protection" I0731 00:53:10.486908 1 shared_informer.go:356] "Caches are synced" controller="cronjob" I0731 00:53:10.487995 1 shared_informer.go:356] "Caches are synced" controller="deployment" I0731 00:53:10.488869 1 shared_informer.go:356] "Caches are synced" controller="endpoint_slice_mirroring" I0731 00:53:10.488942 1 shared_informer.go:356] "Caches are synced" controller="taint" I0731 00:53:10.489023 1 node_lifecycle_controller.go:1221] "Initializing eviction metric for zone" logger="node-lifecycle-controller" zone="" I0731 00:53:10.489082 1 shared_informer.go:356] "Caches are synced" controller="job" I0731 00:53:10.489119 1 node_lifecycle_controller.go:873] "Missing timestamp for Node. Assuming now as a timestamp" logger="node-lifecycle-controller" node="controller" I0731 00:53:10.489178 1 shared_informer.go:356] "Caches are synced" controller="ReplicaSet" I0731 00:53:10.489165 1 node_lifecycle_controller.go:1025] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" logger="node-lifecycle-controller" I0731 00:53:10.489336 1 shared_informer.go:356] "Caches are synced" controller="ReplicationController" I0731 00:53:10.489552 1 shared_informer.go:356] "Caches are synced" controller="VAC protection" I0731 00:53:10.496913 1 shared_informer.go:356] "Caches are synced" controller="namespace" I0731 00:53:10.505302 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:53:10.520610 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0731 00:53:40.511766 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="securitypolicies.gateway.envoyproxy.io" I0731 00:53:40.511803 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tcproutes.gateway.networking.k8s.io" I0731 00:53:40.511820 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xlistenersets.gateway.networking.x-k8s.io" I0731 00:53:40.511850 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0731 00:53:40.511871 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0731 00:53:40.511897 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tlsroutes.gateway.networking.k8s.io" I0731 00:53:40.512287 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backends.gateway.envoyproxy.io" I0731 00:53:40.512384 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="gateways.gateway.networking.k8s.io" I0731 00:53:40.512419 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="referencegrants.gateway.networking.k8s.io" I0731 00:53:40.512450 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyproxies.gateway.envoyproxy.io" I0731 00:53:40.512517 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoypatchpolicies.gateway.envoyproxy.io" I0731 00:53:40.512549 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutes.gateway.networking.k8s.io" I0731 00:53:40.512576 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="udproutes.gateway.networking.k8s.io" I0731 00:53:40.512599 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0731 00:53:40.512617 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutefilters.gateway.envoyproxy.io" I0731 00:53:40.512633 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="grpcroutes.gateway.networking.k8s.io" I0731 00:53:40.512648 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0731 00:53:40.512662 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtlspolicies.gateway.networking.k8s.io" I0731 00:53:40.512804 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:53:40.534624 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:53:42.413001 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:53:42.435240 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0731 00:54:05.684022 1 node_lifecycle_controller.go:1044] "Controller detected that some Nodes are Ready. Exiting master disruption mode" logger="node-lifecycle-controller" I0731 00:54:12.424556 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnetworkpolicies.cilium.io" I0731 00:54:12.424613 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnodeconfigs.cilium.io" I0731 00:54:12.424644 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumendpoints.cilium.io" I0731 00:54:12.424702 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:54:12.449785 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:54:13.525085 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:54:13.551129 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0731 00:54:43.535732 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="challenges.acme.cert-manager.io" I0731 00:54:43.535869 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="certificates.cert-manager.io" I0731 00:54:43.536139 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="issuers.cert-manager.io" I0731 00:54:43.536451 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="orders.acme.cert-manager.io" I0731 00:54:43.536629 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="certificaterequests.cert-manager.io" I0731 00:54:43.536781 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:54:43.563744 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:54:43.637834 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:54:43.664373 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0731 00:55:13.648023 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machines.cluster.x-k8s.io" I0731 00:55:13.648102 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmcontrolplanetemplates.controlplane.cluster.x-k8s.io" I0731 00:55:13.648122 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusterresourcesetbindings.addons.cluster.x-k8s.io" I0731 00:55:13.648140 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusters.cluster.x-k8s.io" I0731 00:55:13.648156 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinesets.cluster.x-k8s.io" I0731 00:55:13.648172 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinedeployments.cluster.x-k8s.io" I0731 00:55:13.648235 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmcontrolplanes.controlplane.cluster.x-k8s.io" I0731 00:55:13.648253 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusterresourcesets.addons.cluster.x-k8s.io" I0731 00:55:13.648270 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinepools.cluster.x-k8s.io" I0731 00:55:13.648292 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackfloatingippools.infrastructure.cluster.x-k8s.io" I0731 00:55:13.648307 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="flavors.openstack.k-orc.cloud" I0731 00:55:13.648322 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmconfigs.bootstrap.cluster.x-k8s.io" I0731 00:55:13.648351 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="subnets.openstack.k-orc.cloud" I0731 00:55:13.648500 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="securitygroups.openstack.k-orc.cloud" I0731 00:55:13.649234 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackclustertemplates.infrastructure.cluster.x-k8s.io" I0731 00:55:13.649294 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="addressscopes.openstack.k-orc.cloud" I0731 00:55:13.649319 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="servers.openstack.k-orc.cloud" I0731 00:55:13.649362 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="providers.clusterctl.cluster.x-k8s.io" I0731 00:55:13.649390 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="routers.openstack.k-orc.cloud" I0731 00:55:13.649412 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="projects.openstack.k-orc.cloud" I0731 00:55:13.649434 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="networks.openstack.k-orc.cloud" I0731 00:55:13.649454 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="volumes.openstack.k-orc.cloud" I0731 00:55:13.649476 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="routerinterfaces.openstack.k-orc.cloud" I0731 00:55:13.649501 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackmachinetemplates.infrastructure.cluster.x-k8s.io" I0731 00:55:13.649521 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="volumetypes.openstack.k-orc.cloud" I0731 00:55:13.649555 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackmachines.infrastructure.cluster.x-k8s.io" I0731 00:55:13.649574 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackclusters.infrastructure.cluster.x-k8s.io" I0731 00:55:13.649599 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="roles.openstack.k-orc.cloud" I0731 00:55:13.649622 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinehealthchecks.cluster.x-k8s.io" I0731 00:55:13.649645 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="kubeadmconfigtemplates.bootstrap.cluster.x-k8s.io" I0731 00:55:13.649758 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="openstackservers.infrastructure.cluster.x-k8s.io" I0731 00:55:13.649883 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ipaddressclaims.ipam.cluster.x-k8s.io" I0731 00:55:13.649971 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="floatingips.openstack.k-orc.cloud" I0731 00:55:13.650049 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="groups.openstack.k-orc.cloud" I0731 00:55:13.650084 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="machinedrainrules.cluster.x-k8s.io" I0731 00:55:13.650111 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="services.openstack.k-orc.cloud" I0731 00:55:13.650141 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ipaddresses.ipam.cluster.x-k8s.io" I0731 00:55:13.650161 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="keypairs.openstack.k-orc.cloud" I0731 00:55:13.650184 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="applicationcredentials.openstack.k-orc.cloud" I0731 00:55:13.650207 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="servergroups.openstack.k-orc.cloud" I0731 00:55:13.650228 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="domains.openstack.k-orc.cloud" I0731 00:55:13.650257 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="images.openstack.k-orc.cloud" I0731 00:55:13.650276 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpoints.openstack.k-orc.cloud" I0731 00:55:13.650308 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="trunks.openstack.k-orc.cloud" I0731 00:55:13.650336 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clusterclasses.cluster.x-k8s.io" I0731 00:55:13.650356 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ports.openstack.k-orc.cloud" I0731 00:55:13.650416 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="users.openstack.k-orc.cloud" I0731 00:55:13.653022 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:55:13.697594 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:55:13.754253 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:55:13.798009 1 shared_informer.go:356] "Caches are synced" controller="garbage collector" I0731 00:55:15.507010 1 namespace_controller.go:187] "Namespace has been deleted" logger="namespace-controller" namespace="cert-manager-test" E0731 00:56:29.971991 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-kubeadm-control-plane-serving-cert-kndwj\", UID:\"8fa343f5-00f0-47c5-8f3d-dcaa8bfdbcb5\", Controller:(*bool)(nil), BlockOwnerDeletion:(*bool)(nil)}, Namespace:\"capi-kubeadm-control-plane-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-kubeadm-control-plane-serving-cert\", UID:\"add7344c-5e47-4876-8f4b-0565e1dffae6\", Controller:(*bool)(0xc002a6592b), BlockOwnerDeletion:(*bool)(0xc002a6592c)}}}: certificaterequests.cert-manager.io \"capi-kubeadm-control-plane-serving-cert-kndwj\" not found" logger="UnhandledError" I0731 00:56:43.788907 1 shared_informer.go:349] "Waiting for caches to sync" controller="resource quota" I0731 00:56:43.836126 1 shared_informer.go:349] "Waiting for caches to sync" controller="garbage collector" I0731 00:56:43.889115 1 shared_informer.go:356] "Caches are synced" controller="resource quota" I0731 00:56:43.936836 1 shared_informer.go:356] "Caches are synced" controller="garbage collector"