I0420 10:53:31.272034 1 serving.go:348] Generated self-signed cert in-memory I0420 10:53:31.881040 1 controllermanager.go:189] "Starting" version="v1.28.13" I0420 10:53:31.881064 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0420 10:53:31.882283 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0420 10:53:31.882418 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0420 10:53:31.882570 1 secure_serving.go:213] Serving securely on [::]:10257 I0420 10:53:31.882683 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0420 10:53:31.883047 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0420 10:53:47.996546 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0420 10:53:47.996728 1 event.go:307] "Event occurred" object="kube-system/kube-controller-manager" fieldPath="" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="instance_ffe5204e-76bd-460c-85bb-1cdcf2d486f3 became leader" I0420 10:53:48.007570 1 shared_informer.go:311] Waiting for caches to sync for tokens I0420 10:53:48.010044 1 controllermanager.go:642] "Started controller" controller="job-controller" I0420 10:53:48.010144 1 job_controller.go:226] "Starting job controller" I0420 10:53:48.010168 1 shared_informer.go:311] Waiting for caches to sync for job I0420 10:53:48.012972 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0420 10:53:48.013668 1 replica_set.go:214] "Starting controller" name="replicaset" I0420 10:53:48.013682 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0420 10:53:48.023808 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0420 10:53:48.023852 1 disruption.go:433] "Sending events to api server." I0420 10:53:48.023920 1 disruption.go:444] "Starting disruption controller" I0420 10:53:48.023933 1 shared_informer.go:311] Waiting for caches to sync for disruption I0420 10:53:48.026078 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0420 10:53:48.026133 1 controller.go:169] "Starting ephemeral volume controller" I0420 10:53:48.026152 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0420 10:53:48.029258 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0420 10:53:48.029345 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0420 10:53:48.029442 1 node_lifecycle_controller.go:465] "Sending events to api server" I0420 10:53:48.029480 1 node_lifecycle_controller.go:476] "Starting node controller" I0420 10:53:48.029485 1 shared_informer.go:311] Waiting for caches to sync for taint I0420 10:53:48.031570 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0420 10:53:48.031616 1 pv_protection_controller.go:78] "Starting PV protection controller" I0420 10:53:48.031630 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0420 10:53:48.033725 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0420 10:53:48.033884 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0420 10:53:48.033912 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0420 10:53:48.056031 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0420 10:53:48.056219 1 namespace_controller.go:197] "Starting namespace controller" I0420 10:53:48.056253 1 shared_informer.go:311] Waiting for caches to sync for namespace I0420 10:53:48.059042 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0420 10:53:48.059073 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0420 10:53:48.059116 1 cleaner.go:83] "Starting CSR cleaner controller" I0420 10:53:48.080763 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0420 10:53:48.080845 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0420 10:53:48.080878 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0420 10:53:48.080908 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="federations.rabbitmq.com" I0420 10:53:48.080953 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="certificates.cert-manager.io" I0420 10:53:48.081051 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0420 10:53:48.081134 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0420 10:53:48.081555 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0420 10:53:48.081604 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0420 10:53:48.081635 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="challenges.acme.cert-manager.io" I0420 10:53:48.081774 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="permissions.rabbitmq.com" I0420 10:53:48.081817 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="exchanges.rabbitmq.com" I0420 10:53:48.081845 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="secretimports.secretgen.carvel.dev" I0420 10:53:48.081879 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0420 10:53:48.081915 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0420 10:53:48.081955 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podmonitors.monitoring.coreos.com" I0420 10:53:48.081998 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="alertmanagerconfigs.monitoring.coreos.com" I0420 10:53:48.082036 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="alertmanagers.monitoring.coreos.com" I0420 10:53:48.082142 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0420 10:53:48.082184 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="prometheuses.monitoring.coreos.com" I0420 10:53:48.082306 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="sshkeys.secretgen.k14s.io" I0420 10:53:48.082344 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0420 10:53:48.082484 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0420 10:53:48.082652 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="issuers.cert-manager.io" I0420 10:53:48.082758 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="perconaxtradbclusterrestores.pxc.percona.com" I0420 10:53:48.082799 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="vhosts.rabbitmq.com" I0420 10:53:48.082867 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="superstreams.rabbitmq.com" I0420 10:53:48.082974 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rsakeys.secretgen.k14s.io" I0420 10:53:48.083079 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0420 10:53:48.083181 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0420 10:53:48.083285 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0420 10:53:48.083386 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0420 10:53:48.083491 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0420 10:53:48.083599 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0420 10:53:48.083775 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0420 10:53:48.083828 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="probes.monitoring.coreos.com" I0420 10:53:48.083921 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0420 10:53:48.084021 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="secretexports.secretgen.carvel.dev" I0420 10:53:48.084060 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0420 10:53:48.084129 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="topicpermissions.rabbitmq.com" I0420 10:53:48.084171 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="policies.rabbitmq.com" I0420 10:53:48.084278 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="prometheusagents.monitoring.coreos.com" I0420 10:53:48.084360 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rabbitmqclusters.rabbitmq.com" I0420 10:53:48.084435 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="bindings.rabbitmq.com" I0420 10:53:48.084545 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0420 10:53:48.084621 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0420 10:53:48.084731 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0420 10:53:48.084771 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0420 10:53:48.084904 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0420 10:53:48.084944 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="schemareplications.rabbitmq.com" I0420 10:53:48.085016 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="secrettemplates.secretgen.carvel.dev" I0420 10:53:48.085053 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0420 10:53:48.085121 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0420 10:53:48.085156 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0420 10:53:48.085241 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0420 10:53:48.085275 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="perconaxtradbclusters.pxc.percona.com" I0420 10:53:48.085350 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="perconaxtradbclusterbackups.pxc.percona.com" I0420 10:53:48.085385 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="shovels.rabbitmq.com" I0420 10:53:48.085654 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0420 10:53:48.085847 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0420 10:53:48.085966 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0420 10:53:48.086091 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="orders.acme.cert-manager.io" I0420 10:53:48.086301 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="thanosrulers.monitoring.coreos.com" I0420 10:53:48.086412 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="queues.rabbitmq.com" I0420 10:53:48.086508 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="passwords.secretgen.k14s.io" I0420 10:53:48.086710 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0420 10:53:48.086869 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0420 10:53:48.086963 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="servicemonitors.monitoring.coreos.com" I0420 10:53:48.087063 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="certificates.secretgen.k14s.io" I0420 10:53:48.087113 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="users.rabbitmq.com" I0420 10:53:48.087198 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="certificaterequests.cert-manager.io" I0420 10:53:48.087359 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="prometheusrules.monitoring.coreos.com" I0420 10:53:48.087453 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="scrapeconfigs.monitoring.coreos.com" I0420 10:53:48.087555 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="operatorpolicies.rabbitmq.com" I0420 10:53:48.087644 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0420 10:53:48.087736 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0420 10:53:48.087810 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0420 10:53:48.087835 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0420 10:53:48.087880 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0420 10:53:48.087926 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0420 10:53:48.087955 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0420 10:53:48.088063 1 resource_quota_controller.go:294] "Starting resource quota controller" I0420 10:53:48.088099 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0420 10:53:48.088254 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0420 10:53:48.090637 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0420 10:53:48.090913 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0420 10:53:48.093681 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0420 10:53:48.093814 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0420 10:53:48.093831 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0420 10:53:48.097748 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0420 10:53:48.097921 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0420 10:53:48.097944 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0420 10:53:48.100294 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0420 10:53:48.100459 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0420 10:53:48.100482 1 shared_informer.go:311] Waiting for caches to sync for deployment I0420 10:53:48.103499 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0420 10:53:48.103735 1 pv_controller_base.go:319] "Starting persistent volume controller" I0420 10:53:48.103765 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0420 10:53:48.107789 1 shared_informer.go:318] Caches are synced for tokens I0420 10:53:48.111620 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0420 10:53:48.111701 1 horizontal.go:200] "Starting HPA controller" I0420 10:53:48.111740 1 shared_informer.go:311] Waiting for caches to sync for HPA E0420 10:53:48.113930 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0420 10:53:48.113954 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" E0420 10:53:48.115706 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0420 10:53:48.115728 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0420 10:53:48.121665 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0420 10:53:48.121683 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0420 10:53:48.121704 1 graph_builder.go:294] "Running" component="GraphBuilder" I0420 10:53:48.121835 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0420 10:53:48.149331 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0420 10:53:48.149405 1 daemon_controller.go:291] "Starting daemon sets controller" I0420 10:53:48.149413 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0420 10:53:48.250906 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0420 10:53:48.251104 1 stateful_set.go:163] "Starting stateful set controller" I0420 10:53:48.251144 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0420 10:53:48.301712 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0420 10:53:48.301862 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0420 10:53:48.301888 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0420 10:53:48.351255 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0420 10:53:48.351359 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0420 10:53:48.351415 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0420 10:53:48.400971 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0420 10:53:48.401050 1 gc_controller.go:101] "Starting GC controller" I0420 10:53:48.401064 1 shared_informer.go:311] Waiting for caches to sync for GC I0420 10:53:48.451697 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0420 10:53:48.451737 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0420 10:53:48.451772 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0420 10:53:48.452307 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0420 10:53:48.452342 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0420 10:53:48.452378 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0420 10:53:48.452890 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0420 10:53:48.452922 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0420 10:53:48.452936 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0420 10:53:48.453417 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0420 10:53:48.453554 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0420 10:53:48.453702 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0420 10:53:48.453585 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0420 10:53:48.453841 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0420 10:53:48.453619 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0420 10:53:48.501726 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0420 10:53:48.501858 1 attach_detach_controller.go:337] "Starting attach detach controller" I0420 10:53:48.501866 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0420 10:53:48.553237 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0420 10:53:48.553479 1 ttl_controller.go:124] "Starting TTL controller" I0420 10:53:48.553503 1 shared_informer.go:311] Waiting for caches to sync for TTL I0420 10:53:48.600690 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0420 10:53:48.600858 1 tokencleaner.go:112] "Starting token cleaner controller" I0420 10:53:48.600914 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0420 10:53:48.600951 1 shared_informer.go:318] Caches are synced for token_cleaner I0420 10:53:48.651529 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0420 10:53:48.651578 1 expand_controller.go:328] "Starting expand controller" I0420 10:53:48.651629 1 shared_informer.go:311] Waiting for caches to sync for expand I0420 10:53:48.702731 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0420 10:53:48.702832 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0420 10:53:48.702859 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0420 10:53:48.750320 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0420 10:53:48.750576 1 endpoints_controller.go:177] "Starting endpoint controller" I0420 10:53:48.750616 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0420 10:53:48.800907 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0420 10:53:48.801072 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0420 10:53:48.801118 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0420 10:53:48.850318 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0420 10:53:48.850532 1 serviceaccounts_controller.go:111] "Starting service account controller" I0420 10:53:48.850554 1 shared_informer.go:311] Waiting for caches to sync for service account I0420 10:53:48.900824 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0420 10:53:48.901063 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0420 10:53:48.901136 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0420 10:53:48.950000 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0420 10:53:48.950046 1 publisher.go:102] "Starting root CA cert publisher controller" I0420 10:53:48.950072 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0420 10:53:48.953437 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0420 10:53:48.965992 1 actual_state_of_world.go:547] "Failed to update statusUpdateNeeded field in actual state of world" err="Failed to set statusUpdateNeeded to needed true, because nodeName=\"instance\" does not exist" I0420 10:53:48.978386 1 job_controller.go:562] "enqueueing job" key="openstack/horizon-db-init" I0420 10:53:48.978412 1 job_controller.go:562] "enqueueing job" key="openstack/horizon-db-sync" I0420 10:53:48.978428 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-bootstrap" I0420 10:53:48.978436 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-credential-setup" I0420 10:53:48.978453 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-db-init" I0420 10:53:48.978457 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-db-sync" I0420 10:53:48.978551 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-domain-manage" I0420 10:53:48.978591 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-fernet-setup" I0420 10:53:48.978622 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-rabbit-init" I0420 10:53:48.986633 1 job_controller.go:562] "enqueueing job" key="openstack/horizon-db-init" I0420 10:53:48.986710 1 job_controller.go:562] "enqueueing job" key="openstack/horizon-db-sync" I0420 10:53:48.987141 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-bootstrap" I0420 10:53:48.987274 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-credential-setup" I0420 10:53:48.987884 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-db-init" I0420 10:53:48.988109 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-db-sync" I0420 10:53:48.988131 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-domain-manage" I0420 10:53:48.988304 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-fernet-setup" I0420 10:53:48.988546 1 job_controller.go:562] "enqueueing job" key="openstack/keystone-rabbit-init" I0420 10:53:48.991374 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0420 10:53:48.993933 1 shared_informer.go:318] Caches are synced for TTL after finished I0420 10:53:49.000513 1 shared_informer.go:318] Caches are synced for deployment I0420 10:53:49.001148 1 shared_informer.go:318] Caches are synced for GC I0420 10:53:49.001239 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0420 10:53:49.001704 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0420 10:53:49.002551 1 shared_informer.go:318] Caches are synced for attach detach I0420 10:53:49.002737 1 shared_informer.go:318] Caches are synced for cronjob I0420 10:53:49.002934 1 shared_informer.go:318] Caches are synced for PVC protection I0420 10:53:49.003899 1 shared_informer.go:318] Caches are synced for persistent volume I0420 10:53:49.004966 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" E0420 10:53:49.006230 1 attach_detach_controller.go:449] "Error creating spec for volume of pod" err="error processing PVC \"openstack\"/\"valkey-data-valkey-node-1\": PVC openstack/valkey-data-valkey-node-1 has non-bound phase (\"Pending\") or empty pvc.Spec.VolumeName (\"\")" pod="openstack/valkey-node-1" volumeName="valkey-data" I0420 10:53:49.010717 1 shared_informer.go:318] Caches are synced for job I0420 10:53:49.014094 1 shared_informer.go:318] Caches are synced for ReplicaSet I0420 10:53:49.014371 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="cert-manager/cert-manager-75c4c745bc" duration="187.133µs" I0420 10:53:49.014504 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="cert-manager/cert-manager-webhook-548949fc64" duration="80.402µs" I0420 10:53:49.014386 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="cert-manager/cert-manager-cainjector-64b59ddb75" duration="112.662µs" I0420 10:53:49.014676 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="74.121µs" I0420 10:53:49.014789 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="161.572µs" I0420 10:53:49.014805 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf" duration="242.374µs" I0420 10:53:49.014982 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="85.901µs" I0420 10:53:49.015210 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="monitoring/kube-prometheus-stack-operator-cd88cf4bf" duration="43.841µs" I0420 10:53:49.015082 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="589.139µs" I0420 10:53:49.015320 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="monitoring/kube-prometheus-stack-grafana-95ffdb78c" duration="172.122µs" I0420 10:53:49.015360 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="128.342µs" I0420 10:53:49.015384 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/keystone-api-5c949c6f45" duration="86.521µs" I0420 10:53:49.015110 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="98.391µs" I0420 10:53:49.015479 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/memcached-memcached-cf56b6468" duration="111.551µs" I0420 10:53:49.015571 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="secretgen-controller/secretgen-controller-5cf976ccc7" duration="52.621µs" I0420 10:53:49.015575 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/pxc-operator-69cb5bbdb9" duration="197.863µs" I0420 10:53:49.015907 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9" duration="198.673µs" I0420 10:53:49.024950 1 shared_informer.go:318] Caches are synced for disruption I0420 10:53:49.027216 1 shared_informer.go:318] Caches are synced for ephemeral I0420 10:53:49.031753 1 shared_informer.go:318] Caches are synced for PV protection I0420 10:53:49.034027 1 shared_informer.go:318] Caches are synced for ReplicationController I0420 10:53:49.049804 1 shared_informer.go:318] Caches are synced for daemon sets I0420 10:53:49.051200 1 shared_informer.go:318] Caches are synced for crt configmap I0420 10:53:49.051224 1 shared_informer.go:318] Caches are synced for stateful set I0420 10:53:49.051752 1 shared_informer.go:318] Caches are synced for service account I0420 10:53:49.051799 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0420 10:53:49.051918 1 shared_informer.go:318] Caches are synced for expand I0420 10:53:49.052532 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0420 10:53:49.053111 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0420 10:53:49.053206 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0420 10:53:49.053644 1 shared_informer.go:318] Caches are synced for TTL I0420 10:53:49.053799 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0420 10:53:49.056708 1 shared_informer.go:318] Caches are synced for namespace I0420 10:53:49.129907 1 shared_informer.go:318] Caches are synced for taint I0420 10:53:49.130013 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0420 10:53:49.130105 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0420 10:53:49.130204 1 node_lifecycle_controller.go:1071] "Controller detected that zone is now in new state" zone="" newState="Normal" I0420 10:53:49.130235 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0420 10:53:49.130297 1 taint_manager.go:210] "Sending events to api server" I0420 10:53:49.130421 1 event.go:307] "Event occurred" object="instance" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="RegisteredNode" message="Node instance event: Registered Node instance in Controller" I0420 10:53:49.151463 1 shared_informer.go:318] Caches are synced for endpoint I0420 10:53:49.198873 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0420 10:53:49.201878 1 shared_informer.go:318] Caches are synced for endpoint_slice I0420 10:53:49.212027 1 shared_informer.go:318] Caches are synced for HPA I0420 10:53:49.317671 1 job_controller.go:562] "enqueueing job" key="openstack/horizon-db-sync" I0420 10:53:49.325648 1 job_controller.go:562] "enqueueing job" key="openstack/horizon-db-sync" I0420 10:53:49.325745 1 event.go:307] "Event occurred" object="openstack/horizon-db-sync" fieldPath="" kind="Job" apiVersion="batch/v1" type="Normal" reason="Completed" message="Job completed" I0420 10:53:49.417533 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-cluster-operator-54f767cff8" duration="402.100168ms" I0420 10:53:49.417836 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-cluster-operator-54f767cff8" duration="163.412µs" I0420 10:53:49.418950 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-messaging-topology-operator-6f465c979f" duration="403.447896ms" I0420 10:53:49.419197 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-messaging-topology-operator-6f465c979f" duration="147.093µs" I0420 10:53:50.004921 1 request.go:697] Waited for 1.049748504s due to client-side throttling, not priority and fairness, request: GET:https://199.204.45.250:6443/apis/monitoring.coreos.com/v1/prometheusrules?limit=500&resourceVersion=0 I0420 10:53:50.489425 1 shared_informer.go:318] Caches are synced for resource quota I0420 10:53:50.554326 1 shared_informer.go:318] Caches are synced for resource quota I0420 10:53:51.122653 1 shared_informer.go:318] Caches are synced for garbage collector I0420 10:53:51.122697 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0420 10:53:51.202708 1 shared_informer.go:318] Caches are synced for garbage collector I0420 10:53:53.571448 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="163.652µs" I0420 10:53:53.712858 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="237.813µs" I0420 10:53:53.812271 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="162.912µs" I0420 10:53:55.304583 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="56.341µs" I0420 10:53:55.369427 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="154.262µs" I0420 10:53:55.547499 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="92.041µs" I0420 10:53:55.714450 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="17.433302ms" I0420 10:53:55.714902 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="172.763µs" I0420 10:54:03.814909 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-cluster-operator-54f767cff8" duration="10.121836ms" I0420 10:54:03.815032 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-cluster-operator-54f767cff8" duration="79.691µs" I0420 10:54:04.006209 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" I0420 10:54:04.416061 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-messaging-topology-operator-6f465c979f" duration="10.34263ms" I0420 10:54:04.416425 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/rabbitmq-messaging-topology-operator-6f465c979f" duration="110.892µs" I0420 10:54:16.386073 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="129.322µs" I0420 10:54:19.006502 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" I0420 10:54:25.355615 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="12.60357ms" I0420 10:54:25.355791 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="127.403µs" I0420 10:54:34.006297 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" I0420 10:54:39.078819 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="16.313952ms" I0420 10:54:39.079385 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="86.421µs" I0420 10:54:39.122995 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="9.638237ms" I0420 10:54:39.123167 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="127.511µs" I0420 10:54:39.157074 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="13.788096ms" I0420 10:54:39.157188 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="openstack/horizon-768868ffd7" duration="83.741µs" I0420 10:54:49.007121 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" I0420 10:55:04.007069 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" I0420 10:55:19.007798 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled" I0420 10:55:34.008199 1 event.go:307] "Event occurred" object="openstack/valkey-data-valkey-node-1" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForPodScheduled" message="waiting for pod valkey-node-1 to be scheduled"