I0225 15:16:12.278316 1 serving.go:348] Generated self-signed cert in-memory I0225 15:16:12.523795 1 controllermanager.go:189] "Starting" version="v1.28.13" I0225 15:16:12.523823 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0225 15:16:12.525247 1 secure_serving.go:213] Serving securely on [::]:10257 I0225 15:16:12.525389 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0225 15:16:12.525710 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0225 15:16:12.525779 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0225 15:16:12.525880 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0225 15:16:29.609542 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0225 15:16:29.609971 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_1827b588-0e6e-4490-ae75-0c27fd74e292 became leader" I0225 15:16:29.624400 1 shared_informer.go:311] Waiting for caches to sync for tokens I0225 15:16:29.640975 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0225 15:16:29.641183 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0225 15:16:29.641198 1 shared_informer.go:311] Waiting for caches to sync for deployment I0225 15:16:29.643381 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0225 15:16:29.643576 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0225 15:16:29.643592 1 shared_informer.go:311] Waiting for caches to sync for cronjob E0225 15:16:29.680132 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0225 15:16:29.680317 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0225 15:16:29.683051 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0225 15:16:29.683170 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0225 15:16:29.683202 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0225 15:16:29.687014 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0225 15:16:29.687252 1 stateful_set.go:163] "Starting stateful set controller" I0225 15:16:29.687262 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0225 15:16:29.690446 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0225 15:16:29.690739 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0225 15:16:29.692704 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0225 15:16:29.692975 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0225 15:16:29.692986 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0225 15:16:29.701112 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0225 15:16:29.701302 1 controller.go:169] "Starting ephemeral volume controller" I0225 15:16:29.701311 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0225 15:16:29.704696 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0225 15:16:29.704986 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0225 15:16:29.705000 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0225 15:16:29.725238 1 shared_informer.go:318] Caches are synced for tokens I0225 15:16:29.819793 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0225 15:16:29.819872 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0225 15:16:29.819906 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0225 15:16:29.819937 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0225 15:16:29.819981 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0225 15:16:29.820031 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0225 15:16:29.820144 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0225 15:16:29.820176 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0225 15:16:29.820206 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0225 15:16:29.820243 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0225 15:16:29.820277 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0225 15:16:29.820320 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0225 15:16:29.820366 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0225 15:16:29.820400 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0225 15:16:29.820445 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0225 15:16:29.820481 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0225 15:16:29.820523 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0225 15:16:29.820562 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0225 15:16:29.820607 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0225 15:16:29.820683 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0225 15:16:29.820750 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0225 15:16:29.820802 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0225 15:16:29.820833 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0225 15:16:29.820857 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0225 15:16:29.821054 1 resource_quota_controller.go:294] "Starting resource quota controller" I0225 15:16:29.821073 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0225 15:16:29.821098 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0225 15:16:29.823944 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0225 15:16:29.824295 1 daemon_controller.go:291] "Starting daemon sets controller" I0225 15:16:29.824310 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0225 15:16:29.826590 1 controllermanager.go:642] "Started controller" controller="job-controller" I0225 15:16:29.826724 1 job_controller.go:226] "Starting job controller" I0225 15:16:29.826859 1 shared_informer.go:311] Waiting for caches to sync for job I0225 15:16:29.829180 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0225 15:16:29.829221 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0225 15:16:29.829232 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0225 15:16:29.829520 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0225 15:16:29.829542 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0225 15:16:29.829732 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0225 15:16:29.830030 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0225 15:16:29.830044 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0225 15:16:29.830066 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0225 15:16:29.830295 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0225 15:16:29.830411 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0225 15:16:29.830428 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0225 15:16:29.830451 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0225 15:16:29.832881 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0225 15:16:29.832906 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0225 15:16:29.833027 1 cleaner.go:83] "Starting CSR cleaner controller" I0225 15:16:29.835666 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0225 15:16:29.835740 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0225 15:16:29.836095 1 node_lifecycle_controller.go:465] "Sending events to api server" I0225 15:16:29.836147 1 node_lifecycle_controller.go:476] "Starting node controller" I0225 15:16:29.836155 1 shared_informer.go:311] Waiting for caches to sync for taint I0225 15:16:29.840608 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0225 15:16:29.841086 1 pv_controller_base.go:319] "Starting persistent volume controller" I0225 15:16:29.841147 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0225 15:16:29.843432 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0225 15:16:29.843565 1 serviceaccounts_controller.go:111] "Starting service account controller" I0225 15:16:29.843616 1 shared_informer.go:311] Waiting for caches to sync for service account I0225 15:16:29.851542 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0225 15:16:29.851623 1 horizontal.go:200] "Starting HPA controller" I0225 15:16:29.852618 1 shared_informer.go:311] Waiting for caches to sync for HPA I0225 15:16:29.856943 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0225 15:16:29.856994 1 disruption.go:433] "Sending events to api server." I0225 15:16:29.857052 1 disruption.go:444] "Starting disruption controller" I0225 15:16:29.857064 1 shared_informer.go:311] Waiting for caches to sync for disruption I0225 15:16:29.858751 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0225 15:16:29.859007 1 tokencleaner.go:112] "Starting token cleaner controller" I0225 15:16:29.859023 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0225 15:16:29.859031 1 shared_informer.go:318] Caches are synced for token_cleaner I0225 15:16:29.860849 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0225 15:16:29.860968 1 attach_detach_controller.go:337] "Starting attach detach controller" I0225 15:16:29.860988 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0225 15:16:29.863041 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0225 15:16:29.863230 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0225 15:16:29.863261 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0225 15:16:29.874292 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0225 15:16:29.874407 1 namespace_controller.go:197] "Starting namespace controller" I0225 15:16:29.874450 1 shared_informer.go:311] Waiting for caches to sync for namespace I0225 15:16:29.877215 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0225 15:16:29.877331 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0225 15:16:29.877383 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0225 15:16:29.877344 1 replica_set.go:214] "Starting controller" name="replicaset" I0225 15:16:29.877547 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet E0225 15:16:29.879354 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0225 15:16:29.879438 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0225 15:16:29.913453 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0225 15:16:29.913530 1 pv_protection_controller.go:78] "Starting PV protection controller" I0225 15:16:29.913562 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0225 15:16:29.962598 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0225 15:16:29.962698 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0225 15:16:29.962706 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0225 15:16:30.084295 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0225 15:16:30.084340 1 ttl_controller.go:124] "Starting TTL controller" I0225 15:16:30.084371 1 shared_informer.go:311] Waiting for caches to sync for TTL I0225 15:16:30.087634 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0225 15:16:30.087712 1 expand_controller.go:328] "Starting expand controller" I0225 15:16:30.087722 1 shared_informer.go:311] Waiting for caches to sync for expand I0225 15:16:30.252017 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0225 15:16:30.252191 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0225 15:16:30.252220 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0225 15:16:30.304762 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0225 15:16:30.304906 1 endpoints_controller.go:177] "Starting endpoint controller" I0225 15:16:30.304934 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0225 15:16:30.307290 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0225 15:16:30.307329 1 gc_controller.go:101] "Starting GC controller" I0225 15:16:30.307359 1 shared_informer.go:311] Waiting for caches to sync for GC I0225 15:16:30.363156 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0225 15:16:30.363184 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0225 15:16:30.363198 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0225 15:16:30.363209 1 graph_builder.go:294] "Running" component="GraphBuilder" I0225 15:16:30.452220 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0225 15:16:30.452384 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0225 15:16:30.452399 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0225 15:16:30.539110 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0225 15:16:30.539208 1 publisher.go:102] "Starting root CA cert publisher controller" I0225 15:16:30.539247 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0225 15:16:30.541477 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0225 15:16:30.553388 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0225 15:16:30.554071 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" I0225 15:16:30.557953 1 shared_informer.go:318] Caches are synced for disruption I0225 15:16:30.561418 1 shared_informer.go:318] Caches are synced for attach detach I0225 15:16:30.563436 1 shared_informer.go:318] Caches are synced for ReplicationController I0225 15:16:30.563475 1 shared_informer.go:318] Caches are synced for endpoint_slice I0225 15:16:30.578010 1 shared_informer.go:318] Caches are synced for ReplicaSet I0225 15:16:30.578396 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="119.523µs" I0225 15:16:30.578400 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="150.143µs" I0225 15:16:30.581233 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0225 15:16:30.585426 1 shared_informer.go:318] Caches are synced for PVC protection I0225 15:16:30.585497 1 shared_informer.go:318] Caches are synced for TTL I0225 15:16:30.587331 1 shared_informer.go:318] Caches are synced for stateful set I0225 15:16:30.587908 1 shared_informer.go:318] Caches are synced for expand I0225 15:16:30.591196 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0225 15:16:30.601588 1 shared_informer.go:318] Caches are synced for ephemeral I0225 15:16:30.605066 1 shared_informer.go:318] Caches are synced for endpoint I0225 15:16:30.605422 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0225 15:16:30.607795 1 shared_informer.go:318] Caches are synced for GC I0225 15:16:30.613678 1 shared_informer.go:318] Caches are synced for PV protection I0225 15:16:30.624677 1 shared_informer.go:318] Caches are synced for daemon sets I0225 15:16:30.629845 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0225 15:16:30.629880 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0225 15:16:30.631063 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0225 15:16:30.631122 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0225 15:16:30.636732 1 shared_informer.go:318] Caches are synced for taint I0225 15:16:30.636822 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0225 15:16:30.636878 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0225 15:16:30.636891 1 taint_manager.go:210] "Sending events to api server" I0225 15:16:30.637029 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0225 15:16:30.637123 1 node_lifecycle_controller.go:1071] "Controller detected that zone is now in new state" zone="" newState="Normal" I0225 15:16:30.637180 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" I0225 15:16:30.640471 1 shared_informer.go:318] Caches are synced for crt configmap I0225 15:16:30.641643 1 shared_informer.go:318] Caches are synced for deployment I0225 15:16:30.641701 1 shared_informer.go:318] Caches are synced for persistent volume I0225 15:16:30.643740 1 shared_informer.go:318] Caches are synced for cronjob I0225 15:16:30.653262 1 shared_informer.go:318] Caches are synced for HPA I0225 15:16:30.653343 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0225 15:16:30.693130 1 shared_informer.go:318] Caches are synced for TTL after finished I0225 15:16:30.722181 1 shared_informer.go:318] Caches are synced for resource quota I0225 15:16:30.727377 1 shared_informer.go:318] Caches are synced for job I0225 15:16:30.742141 1 shared_informer.go:318] Caches are synced for resource quota I0225 15:16:30.743923 1 shared_informer.go:318] Caches are synced for service account I0225 15:16:30.775262 1 shared_informer.go:318] Caches are synced for namespace I0225 15:16:31.038703 1 reconciler.go:267] "attacherDetacher.DetachVolume started" node="instance" volumeName="kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-dfaa42c1-25bb-49f9-984b-97063ff9de45" I0225 15:16:31.150325 1 operation_generator.go:1636] Verified volume is safe to detach for volume "nil" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-dfaa42c1-25bb-49f9-984b-97063ff9de45") on node "instance" I0225 15:16:31.164238 1 shared_informer.go:318] Caches are synced for garbage collector I0225 15:16:31.164321 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0225 15:16:31.182371 1 shared_informer.go:318] Caches are synced for garbage collector I0225 15:16:31.721269 1 operation_generator.go:520] DetachVolume.Detach succeeded for volume "nil" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-dfaa42c1-25bb-49f9-984b-97063ff9de45") on node "instance" I0225 15:16:31.805198 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="1.22695245s" I0225 15:16:31.805287 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="62.271µs" I0225 15:16:31.807395 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-795cfbf7fb" duration="1.229180209s" I0225 15:16:31.807473 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-795cfbf7fb" duration="54.641µs"