I0611 17:42:06.390761 1 serving.go:386] Generated self-signed cert in-memory I0611 17:42:06.967208 1 controllermanager.go:185] "Starting" version="v1.32.10" I0611 17:42:06.967225 1 controllermanager.go:187] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0611 17:42:06.972915 1 dynamic_cafile_content.go:161] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0611 17:42:06.973004 1 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0611 17:42:06.973224 1 secure_serving.go:213] Serving securely on [::]:10257 I0611 17:42:06.973311 1 tlsconfig.go:243] "Starting DynamicServingCertificateController" I0611 17:42:06.973541 1 leaderelection.go:257] attempting to acquire leader lease kube-system/kube-controller-manager... E0611 17:42:07.705440 1 leaderelection.go:436] 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" I0611 17:42:10.977015 1 leaderelection.go:271] successfully acquired lease kube-system/kube-controller-manager I0611 17:42:10.977239 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="instance_3c6e2862-40e9-48d5-8730-b76faaea8427 became leader" I0611 17:42:10.981077 1 controllermanager.go:765] "Started controller" controller="serviceaccount-token-controller" I0611 17:42:10.981108 1 shared_informer.go:313] Waiting for caches to sync for tokens I0611 17:42:10.987666 1 controllermanager.go:765] "Started controller" controller="endpoints-controller" I0611 17:42:10.987747 1 endpoints_controller.go:182] "Starting endpoint controller" logger="endpoints-controller" I0611 17:42:10.987774 1 shared_informer.go:313] Waiting for caches to sync for endpoint I0611 17:42:10.995389 1 controllermanager.go:765] "Started controller" controller="deployment-controller" I0611 17:42:10.995566 1 deployment_controller.go:173] "Starting controller" logger="deployment-controller" controller="deployment" I0611 17:42:10.995587 1 shared_informer.go:313] Waiting for caches to sync for deployment I0611 17:42:11.000563 1 controllermanager.go:765] "Started controller" controller="bootstrap-signer-controller" I0611 17:42:11.000688 1 shared_informer.go:313] Waiting for caches to sync for bootstrap_signer I0611 17:42:11.005182 1 controllermanager.go:765] "Started controller" controller="persistentvolume-attach-detach-controller" I0611 17:42:11.005330 1 attach_detach_controller.go:338] "Starting attach detach controller" logger="persistentvolume-attach-detach-controller" I0611 17:42:11.005343 1 shared_informer.go:313] Waiting for caches to sync for attach detach I0611 17:42:11.013205 1 controllermanager.go:765] "Started controller" controller="endpointslice-controller" I0611 17:42:11.013374 1 endpointslice_controller.go:281] "Starting endpoint slice controller" logger="endpointslice-controller" I0611 17:42:11.013393 1 shared_informer.go:313] Waiting for caches to sync for endpoint_slice W0611 17:42:11.042215 1 shared_informer.go:597] resyncPeriod 14h7m14.825052575s is smaller than resyncCheckPeriod 17h44m44.302716203s and the informer has already started. Changing it to 17h44m44.302716203s I0611 17:42:11.042304 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="serviceaccounts" I0611 17:42:11.042426 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="jobs.batch" I0611 17:42:11.042623 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ingresses.networking.k8s.io" I0611 17:42:11.042665 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="limitranges" I0611 17:42:11.042714 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="daemonsets.apps" I0611 17:42:11.042742 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="networkpolicies.networking.k8s.io" I0611 17:42:11.042771 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="poddisruptionbudgets.policy" I0611 17:42:11.042800 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="statefulsets.apps" I0611 17:42:11.042826 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="leases.coordination.k8s.io" I0611 17:42:11.042870 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="podtemplates" I0611 17:42:11.042901 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="controllerrevisions.apps" I0611 17:42:11.042920 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="deployments.apps" W0611 17:42:11.042958 1 shared_informer.go:597] resyncPeriod 17h23m24.934488459s is smaller than resyncCheckPeriod 17h44m44.302716203s and the informer has already started. Changing it to 17h44m44.302716203s I0611 17:42:11.043019 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="replicasets.apps" I0611 17:42:11.043060 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="horizontalpodautoscalers.autoscaling" I0611 17:42:11.043087 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpointslices.discovery.k8s.io" I0611 17:42:11.043105 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpoints" I0611 17:42:11.043129 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="cronjobs.batch" I0611 17:42:11.043161 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="roles.rbac.authorization.k8s.io" I0611 17:42:11.043192 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="csistoragecapacities.storage.k8s.io" I0611 17:42:11.043216 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="rolebindings.rbac.authorization.k8s.io" I0611 17:42:11.043272 1 controllermanager.go:765] "Started controller" controller="resourcequota-controller" I0611 17:42:11.043317 1 resource_quota_controller.go:300] "Starting resource quota controller" logger="resourcequota-controller" I0611 17:42:11.043356 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0611 17:42:11.043402 1 resource_quota_monitor.go:308] "QuotaMonitor running" logger="resourcequota-controller" I0611 17:42:11.056716 1 controllermanager.go:765] "Started controller" controller="serviceaccount-controller" I0611 17:42:11.056852 1 serviceaccounts_controller.go:114] "Starting service account controller" logger="serviceaccount-controller" I0611 17:42:11.056865 1 shared_informer.go:313] Waiting for caches to sync for service account I0611 17:42:11.062914 1 controllermanager.go:765] "Started controller" controller="persistentvolume-protection-controller" I0611 17:42:11.062934 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="volumeattributesclass-protection-controller" requiredFeatureGates=["VolumeAttributesClass"] I0611 17:42:11.062963 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="service-cidr-controller" requiredFeatureGates=["MultiCIDRServiceAllocator"] I0611 17:42:11.062974 1 controllermanager.go:743] "Warning: skipping controller" controller="storage-version-migrator-controller" I0611 17:42:11.063014 1 pv_protection_controller.go:81] "Starting PV protection controller" logger="persistentvolume-protection-controller" I0611 17:42:11.063050 1 shared_informer.go:313] Waiting for caches to sync for PV protection I0611 17:42:11.081610 1 shared_informer.go:320] Caches are synced for tokens I0611 17:42:11.131138 1 controllermanager.go:765] "Started controller" controller="garbage-collector-controller" I0611 17:42:11.131137 1 garbagecollector.go:144] "Starting controller" logger="garbage-collector-controller" controller="garbagecollector" I0611 17:42:11.131233 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0611 17:42:11.131313 1 graph_builder.go:351] "Running" logger="garbage-collector-controller" component="GraphBuilder" I0611 17:42:11.529726 1 controllermanager.go:765] "Started controller" controller="horizontal-pod-autoscaler-controller" I0611 17:42:11.529769 1 horizontal.go:201] "Starting HPA controller" logger="horizontal-pod-autoscaler-controller" I0611 17:42:11.530015 1 shared_informer.go:313] Waiting for caches to sync for HPA I0611 17:42:11.682447 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-serving" I0611 17:42:11.682492 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0611 17:42:11.682517 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0611 17:42:11.683399 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-client" I0611 17:42:11.683439 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0611 17:42:11.683451 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0611 17:42:11.684174 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kube-apiserver-client" I0611 17:42:11.684211 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0611 17:42:11.684240 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0611 17:42:11.684932 1 controllermanager.go:765] "Started controller" controller="certificatesigningrequest-signing-controller" I0611 17:42:11.684987 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-legacy-unknown" I0611 17:42:11.685009 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0611 17:42:11.685032 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0611 17:42:11.835356 1 controllermanager.go:765] "Started controller" controller="token-cleaner-controller" I0611 17:42:11.835381 1 controllermanager.go:743] "Warning: skipping controller" controller="node-ipam-controller" I0611 17:42:11.835386 1 controllermanager.go:723] "Skipping a cloud provider controller" controller="cloud-node-lifecycle-controller" I0611 17:42:11.835395 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="storageversion-garbage-collector-controller" requiredFeatureGates=["APIServerIdentity","StorageVersionAPI"] I0611 17:42:11.835450 1 tokencleaner.go:117] "Starting token cleaner controller" logger="token-cleaner-controller" I0611 17:42:11.835460 1 shared_informer.go:313] Waiting for caches to sync for token_cleaner I0611 17:42:11.835468 1 shared_informer.go:320] Caches are synced for token_cleaner I0611 17:42:11.981895 1 controllermanager.go:765] "Started controller" controller="legacy-serviceaccount-token-cleaner-controller" I0611 17:42:11.981939 1 legacy_serviceaccount_token_cleaner.go:103] "Starting legacy service account token cleaner controller" logger="legacy-serviceaccount-token-cleaner-controller" I0611 17:42:11.981949 1 shared_informer.go:313] Waiting for caches to sync for legacy-service-account-token-cleaner I0611 17:42:12.133031 1 controllermanager.go:765] "Started controller" controller="pod-garbage-collector-controller" I0611 17:42:12.133091 1 gc_controller.go:99] "Starting GC controller" logger="pod-garbage-collector-controller" I0611 17:42:12.133100 1 shared_informer.go:313] Waiting for caches to sync for GC I0611 17:42:12.283004 1 controllermanager.go:765] "Started controller" controller="job-controller" I0611 17:42:12.283272 1 job_controller.go:243] "Starting job controller" logger="job-controller" I0611 17:42:12.283304 1 shared_informer.go:313] Waiting for caches to sync for job I0611 17:42:12.432314 1 controllermanager.go:765] "Started controller" controller="statefulset-controller" I0611 17:42:12.432435 1 stateful_set.go:166] "Starting stateful set controller" logger="statefulset-controller" I0611 17:42:12.432517 1 shared_informer.go:313] Waiting for caches to sync for stateful set I0611 17:42:12.480667 1 controllermanager.go:765] "Started controller" controller="certificatesigningrequest-approving-controller" I0611 17:42:12.480693 1 controllermanager.go:723] "Skipping a cloud provider controller" controller="node-route-controller" I0611 17:42:12.480715 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-approving-controller" name="csrapproving" I0611 17:42:12.480771 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrapproving I0611 17:42:12.632807 1 controllermanager.go:765] "Started controller" controller="persistentvolume-expander-controller" I0611 17:42:12.632864 1 expand_controller.go:329] "Starting expand controller" logger="persistentvolume-expander-controller" I0611 17:42:12.632874 1 shared_informer.go:313] Waiting for caches to sync for expand I0611 17:42:12.782042 1 controllermanager.go:765] "Started controller" controller="persistentvolumeclaim-protection-controller" I0611 17:42:12.782102 1 pvc_protection_controller.go:168] "Starting PVC protection controller" logger="persistentvolumeclaim-protection-controller" I0611 17:42:12.782113 1 shared_informer.go:313] Waiting for caches to sync for PVC protection I0611 17:42:13.040217 1 controllermanager.go:765] "Started controller" controller="namespace-controller" I0611 17:42:13.040280 1 namespace_controller.go:202] "Starting namespace controller" logger="namespace-controller" I0611 17:42:13.040294 1 shared_informer.go:313] Waiting for caches to sync for namespace I0611 17:42:13.231414 1 controllermanager.go:765] "Started controller" controller="disruption-controller" I0611 17:42:13.231491 1 disruption.go:452] "Sending events to api server." logger="disruption-controller" I0611 17:42:13.231718 1 disruption.go:463] "Starting disruption controller" logger="disruption-controller" I0611 17:42:13.231765 1 shared_informer.go:313] Waiting for caches to sync for disruption I0611 17:42:13.280703 1 controllermanager.go:765] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0611 17:42:13.280771 1 cleaner.go:83] "Starting CSR cleaner controller" logger="certificatesigningrequest-cleaner-controller" I0611 17:42:13.433603 1 node_lifecycle_controller.go:432] "Controller will reconcile labels" logger="node-lifecycle-controller" I0611 17:42:13.433666 1 controllermanager.go:765] "Started controller" controller="node-lifecycle-controller" I0611 17:42:13.433677 1 controllermanager.go:723] "Skipping a cloud provider controller" controller="service-lb-controller" I0611 17:42:13.433750 1 node_lifecycle_controller.go:466] "Sending events to api server" logger="node-lifecycle-controller" I0611 17:42:13.433780 1 node_lifecycle_controller.go:477] "Starting node controller" logger="node-lifecycle-controller" I0611 17:42:13.433798 1 shared_informer.go:313] Waiting for caches to sync for taint I0611 17:42:13.582756 1 controllermanager.go:765] "Started controller" controller="clusterrole-aggregation-controller" I0611 17:42:13.582880 1 clusterroleaggregation_controller.go:194] "Starting ClusterRoleAggregator controller" logger="clusterrole-aggregation-controller" I0611 17:42:13.582924 1 shared_informer.go:313] Waiting for caches to sync for ClusterRoleAggregator I0611 17:42:13.733467 1 controllermanager.go:765] "Started controller" controller="root-ca-certificate-publisher-controller" I0611 17:42:13.733557 1 publisher.go:107] "Starting root CA cert publisher controller" logger="root-ca-certificate-publisher-controller" I0611 17:42:13.733568 1 shared_informer.go:313] Waiting for caches to sync for crt configmap I0611 17:42:13.882772 1 controllermanager.go:765] "Started controller" controller="ephemeral-volume-controller" I0611 17:42:13.882870 1 controller.go:173] "Starting ephemeral volume controller" logger="ephemeral-volume-controller" I0611 17:42:13.882889 1 shared_informer.go:313] Waiting for caches to sync for ephemeral I0611 17:42:14.032631 1 controllermanager.go:765] "Started controller" controller="replicaset-controller" I0611 17:42:14.032742 1 replica_set.go:217] "Starting controller" logger="replicaset-controller" name="replicaset" I0611 17:42:14.032764 1 shared_informer.go:313] Waiting for caches to sync for ReplicaSet I0611 17:42:14.183033 1 controllermanager.go:765] "Started controller" controller="replicationcontroller-controller" I0611 17:42:14.183197 1 replica_set.go:217] "Starting controller" logger="replicationcontroller-controller" name="replicationcontroller" I0611 17:42:14.183221 1 shared_informer.go:313] Waiting for caches to sync for ReplicationController I0611 17:42:14.332433 1 controllermanager.go:765] "Started controller" controller="cronjob-controller" I0611 17:42:14.332594 1 cronjob_controllerv2.go:145] "Starting cronjob controller v2" logger="cronjob-controller" I0611 17:42:14.332626 1 shared_informer.go:313] Waiting for caches to sync for cronjob I0611 17:42:14.482947 1 controllermanager.go:765] "Started controller" controller="ttl-controller" I0611 17:42:14.483052 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="selinux-warning-controller" requiredFeatureGates=["SELinuxChangePolicy"] I0611 17:42:14.483143 1 ttl_controller.go:127] "Starting TTL controller" logger="ttl-controller" I0611 17:42:14.483179 1 shared_informer.go:313] Waiting for caches to sync for TTL I0611 17:42:14.633064 1 controllermanager.go:765] "Started controller" controller="daemonset-controller" I0611 17:42:14.633311 1 daemon_controller.go:294] "Starting daemon sets controller" logger="daemonset-controller" I0611 17:42:14.633343 1 shared_informer.go:313] Waiting for caches to sync for daemon sets I0611 17:42:14.782449 1 controllermanager.go:765] "Started controller" controller="ttl-after-finished-controller" I0611 17:42:14.782529 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="kube-apiserver-serving-clustertrustbundle-publisher-controller" requiredFeatureGates=["ClusterTrustBundle"] I0611 17:42:14.782800 1 ttlafterfinished_controller.go:112] "Starting TTL after finished controller" logger="ttl-after-finished-controller" I0611 17:42:14.782843 1 shared_informer.go:313] Waiting for caches to sync for TTL after finished I0611 17:42:14.979969 1 controllermanager.go:765] "Started controller" controller="validatingadmissionpolicy-status-controller" I0611 17:42:14.980042 1 shared_informer.go:313] Waiting for caches to sync for validatingadmissionpolicy-status I0611 17:42:15.030851 1 controllermanager.go:765] "Started controller" controller="taint-eviction-controller" I0611 17:42:15.030902 1 taint_eviction.go:281] "Starting" logger="taint-eviction-controller" controller="taint-eviction-controller" I0611 17:42:15.030978 1 taint_eviction.go:287] "Sending events to api server" logger="taint-eviction-controller" I0611 17:42:15.031018 1 shared_informer.go:313] Waiting for caches to sync for taint-eviction-controller I0611 17:42:15.186829 1 controllermanager.go:765] "Started controller" controller="endpointslice-mirroring-controller" I0611 17:42:15.187068 1 endpointslicemirroring_controller.go:227] "Starting EndpointSliceMirroring controller" logger="endpointslice-mirroring-controller" I0611 17:42:15.187110 1 shared_informer.go:313] Waiting for caches to sync for endpoint_slice_mirroring I0611 17:42:15.332860 1 controllermanager.go:765] "Started controller" controller="persistentvolume-binder-controller" I0611 17:42:15.332889 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="resourceclaim-controller" requiredFeatureGates=["DynamicResourceAllocation"] I0611 17:42:15.333001 1 pv_controller_base.go:308] "Starting persistent volume controller" logger="persistentvolume-binder-controller" I0611 17:42:15.333037 1 shared_informer.go:313] Waiting for caches to sync for persistent volume I0611 17:42:15.337093 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0611 17:42:15.353678 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0611 17:42:15.361162 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=\"instance\" does not exist" I0611 17:42:15.365209 1 shared_informer.go:320] Caches are synced for PV protection I0611 17:42:15.380274 1 shared_informer.go:320] Caches are synced for validatingadmissionpolicy-status I0611 17:42:15.381511 1 shared_informer.go:320] Caches are synced for certificate-csrapproving I0611 17:42:15.382119 1 shared_informer.go:320] Caches are synced for legacy-service-account-token-cleaner I0611 17:42:15.382194 1 shared_informer.go:320] Caches are synced for PVC protection I0611 17:42:15.383222 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-kubelet-serving I0611 17:42:15.383386 1 shared_informer.go:320] Caches are synced for job I0611 17:42:15.383474 1 shared_informer.go:320] Caches are synced for TTL after finished I0611 17:42:15.383514 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-kubelet-client I0611 17:42:15.383517 1 shared_informer.go:320] Caches are synced for TTL I0611 17:42:15.383672 1 shared_informer.go:320] Caches are synced for ClusterRoleAggregator I0611 17:42:15.384401 1 shared_informer.go:320] Caches are synced for ephemeral I0611 17:42:15.384493 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-kube-apiserver-client I0611 17:42:15.384584 1 shared_informer.go:320] Caches are synced for ReplicationController I0611 17:42:15.385354 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-legacy-unknown I0611 17:42:15.387889 1 shared_informer.go:320] Caches are synced for endpoint_slice_mirroring I0611 17:42:15.387941 1 shared_informer.go:320] Caches are synced for endpoint I0611 17:42:15.396186 1 shared_informer.go:320] Caches are synced for deployment I0611 17:42:15.401421 1 shared_informer.go:320] Caches are synced for bootstrap_signer I0611 17:42:15.405650 1 shared_informer.go:320] Caches are synced for attach detach I0611 17:42:15.413870 1 shared_informer.go:320] Caches are synced for endpoint_slice I0611 17:42:15.430984 1 shared_informer.go:320] Caches are synced for HPA I0611 17:42:15.431078 1 shared_informer.go:320] Caches are synced for taint-eviction-controller I0611 17:42:15.431323 1 shared_informer.go:320] Caches are synced for garbage collector I0611 17:42:15.431384 1 garbagecollector.go:154] "Garbage collector: all resource monitors have synced" logger="garbage-collector-controller" I0611 17:42:15.431423 1 garbagecollector.go:157] "Proceeding to collect garbage" logger="garbage-collector-controller" I0611 17:42:15.432363 1 shared_informer.go:320] Caches are synced for disruption I0611 17:42:15.433506 1 shared_informer.go:320] Caches are synced for GC I0611 17:42:15.433550 1 shared_informer.go:320] Caches are synced for expand I0611 17:42:15.433588 1 shared_informer.go:320] Caches are synced for ReplicaSet I0611 17:42:15.433590 1 shared_informer.go:320] Caches are synced for cronjob I0611 17:42:15.433640 1 shared_informer.go:320] Caches are synced for crt configmap I0611 17:42:15.433726 1 shared_informer.go:320] Caches are synced for daemon sets I0611 17:42:15.433935 1 shared_informer.go:320] Caches are synced for taint I0611 17:42:15.434098 1 shared_informer.go:320] Caches are synced for persistent volume I0611 17:42:15.434210 1 shared_informer.go:320] Caches are synced for stateful set I0611 17:42:15.434237 1 node_lifecycle_controller.go:1234] "Initializing eviction metric for zone" logger="node-lifecycle-controller" zone="" I0611 17:42:15.434419 1 node_lifecycle_controller.go:886] "Missing timestamp for Node. Assuming now as a timestamp" logger="node-lifecycle-controller" node="instance" I0611 17:42:15.434537 1 node_lifecycle_controller.go:1038] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" logger="node-lifecycle-controller" I0611 17:42:15.437583 1 shared_informer.go:320] Caches are synced for resource quota I0611 17:42:15.440844 1 shared_informer.go:320] Caches are synced for namespace I0611 17:42:15.444059 1 shared_informer.go:320] Caches are synced for resource quota I0611 17:42:15.454427 1 shared_informer.go:320] Caches are synced for garbage collector I0611 17:42:15.457633 1 shared_informer.go:320] Caches are synced for service account I0611 17:42:16.661296 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="420.99666ms" I0611 17:42:16.671570 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="10.245807ms" I0611 17:42:16.671622 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="27.84µs" I0611 17:42:27.994370 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="14.139374ms" I0611 17:42:28.003912 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="9.494741ms" I0611 17:42:28.004024 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="64.491µs" I0611 17:42:28.017604 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="21.469532ms" I0611 17:42:28.026322 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="13.790565ms" I0611 17:42:28.030929 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="13.21519ms" I0611 17:42:28.031081 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="120.323µs" I0611 17:42:28.033393 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="6.957238ms" I0611 17:42:28.047046 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="13.624571ms" I0611 17:42:28.047134 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="47.211µs" I0611 17:42:39.550888 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="30.654825ms" I0611 17:42:39.575345 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="24.29724ms" I0611 17:42:39.575544 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="162.254µs" I0611 17:42:45.442650 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="securitypolicies.gateway.envoyproxy.io" I0611 17:42:45.442696 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backends.gateway.envoyproxy.io" I0611 17:42:45.442712 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="udproutes.gateway.networking.k8s.io" I0611 17:42:45.442732 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0611 17:42:45.442748 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutefilters.gateway.envoyproxy.io" I0611 17:42:45.442765 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoypatchpolicies.gateway.envoyproxy.io" I0611 17:42:45.442798 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="referencegrants.gateway.networking.k8s.io" I0611 17:42:45.442817 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tlsroutes.gateway.networking.k8s.io" I0611 17:42:45.442834 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0611 17:42:45.442847 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xlistenersets.gateway.networking.x-k8s.io" I0611 17:42:45.442860 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtlspolicies.gateway.networking.k8s.io" I0611 17:42:45.442876 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0611 17:42:45.442898 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyproxies.gateway.envoyproxy.io" I0611 17:42:45.442910 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0611 17:42:45.442922 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="gateways.gateway.networking.k8s.io" I0611 17:42:45.442937 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="grpcroutes.gateway.networking.k8s.io" I0611 17:42:45.442949 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutes.gateway.networking.k8s.io" I0611 17:42:45.442960 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tcproutes.gateway.networking.k8s.io" I0611 17:42:45.443101 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0611 17:42:45.464620 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0611 17:42:47.365775 1 shared_informer.go:320] Caches are synced for garbage collector I0611 17:42:47.443820 1 shared_informer.go:320] Caches are synced for resource quota I0611 17:42:47.904839 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="0s" I0611 17:42:47.925427 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:42:47.941290 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:42:47.941290 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:42:49.062539 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="57.171µs" I0611 17:42:50.089877 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="11.982132ms" I0611 17:42:50.089969 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="56.561µs" I0611 17:42:53.824405 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="51.781µs" I0611 17:42:53.826588 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="95.723µs" I0611 17:42:53.838580 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="71.921µs" I0611 17:42:53.838673 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="65.151µs" I0611 17:42:53.850627 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:42:53.862222 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:42:55.440330 1 node_lifecycle_controller.go:1057] "Controller detected that some Nodes are Ready. Exiting master disruption mode" logger="node-lifecycle-controller" I0611 17:42:56.264842 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="132.553µs" I0611 17:42:56.272838 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="49.831µs" I0611 17:43:00.120857 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="114.443µs" I0611 17:43:00.139282 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="7.715958ms" I0611 17:43:00.139515 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="76.682µs" I0611 17:43:02.366000 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="39.371µs" I0611 17:43:02.372441 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="24.641µs" I0611 17:43:03.187675 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:43:04.134785 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:43:05.332007 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:43:06.345785 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:43:06.359462 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0611 17:43:06.526984 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="24.836064ms" I0611 17:43:06.539444 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="12.407913ms" I0611 17:43:06.539621 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="129.353µs" I0611 17:43:06.562632 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="70.902µs" I0611 17:43:08.146068 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="163.254µs" I0611 17:43:11.269890 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="129.043µs" I0611 17:43:11.270228 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="39.751µs" I0611 17:43:11.285815 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="112.962µs" I0611 17:43:11.296245 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="59.321µs" I0611 17:43:12.165737 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="151.793µs" I0611 17:43:12.179962 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="50.911µs" I0611 17:43:13.174795 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="8.133678ms" I0611 17:43:13.174920 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="84.622µs" I0611 17:43:13.187642 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="7.776299ms" I0611 17:43:13.187722 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="45.411µs" I0611 17:43:13.204838 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="20.622941ms" I0611 17:43:13.211573 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="6.691473ms" I0611 17:43:13.211711 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="72.941µs" I0611 17:43:17.379691 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0611 17:43:17.450580 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumendpoints.cilium.io" W0611 17:43:17.450735 1 shared_informer.go:597] resyncPeriod 13h4m8.072479583s is smaller than resyncCheckPeriod 14h20m11.351559159s and the informer has already started. Changing it to 14h20m11.351559159s I0611 17:43:17.450795 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnetworkpolicies.cilium.io" I0611 17:43:17.450929 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnodeconfigs.cilium.io" I0611 17:43:17.451048 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0611 17:43:18.451655 1 shared_informer.go:320] Caches are synced for resource quota I0611 17:43:18.453822 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="130.903µs" I0611 17:43:18.481036 1 shared_informer.go:320] Caches are synced for garbage collector I0611 17:43:19.161005 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="8.601419ms" I0611 17:43:19.161315 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="246.576µs" I0611 17:43:19.183533 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="57.741µs" I0611 17:43:19.186103 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="44.761µs" I0611 17:43:36.041504 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="0s" I0611 17:44:12.964462 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="35.302778ms" I0611 17:44:12.981488 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="16.992377ms" I0611 17:44:12.981874 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="80.222µs" I0611 17:44:13.005473 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="53.241µs" I0611 17:44:39.525941 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="14.606189ms" I0611 17:44:39.526248 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="247.926µs" I0611 17:48:16.542552 1 reconciler.go:360] "attacherDetacher.AttachVolume started" logger="persistentvolume-attach-detach-controller" volumeName="kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-59ea1fca-3b46-405d-822a-ff185d609063" nodeName="instance" scheduledPods=["default/test-pvc-pod"] I0611 17:48:17.111990 1 operation_generator.go:298] AttachVolume.Attach succeeded for volume "pvc-52ff8d24-9f9f-424f-bbb6-bcbf32282dc9" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-59ea1fca-3b46-405d-822a-ff185d609063") from node "instance" I0611 17:48:29.456848 1 reconciler.go:275] "attacherDetacher.DetachVolume started" logger="persistentvolume-attach-detach-controller" node="instance" volumeName="kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-59ea1fca-3b46-405d-822a-ff185d609063" I0611 17:48:29.459606 1 operation_generator.go:1516] Verified volume is safe to detach for volume "pvc-52ff8d24-9f9f-424f-bbb6-bcbf32282dc9" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-59ea1fca-3b46-405d-822a-ff185d609063") on node "instance" I0611 17:48:29.977996 1 operation_generator.go:414] DetachVolume.Detach succeeded for volume "pvc-52ff8d24-9f9f-424f-bbb6-bcbf32282dc9" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-59ea1fca-3b46-405d-822a-ff185d609063") on node "instance"