I0410 03:51:08.759003 1 serving.go:348] Generated self-signed cert in-memory I0410 03:51:09.158778 1 controllermanager.go:189] "Starting" version="v1.28.13" I0410 03:51:09.158872 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0410 03:51:09.160194 1 secure_serving.go:213] Serving securely on [::]:10257 I0410 03:51:09.160355 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0410 03:51:09.160639 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0410 03:51:09.160737 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0410 03:51:09.160798 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" E0410 03:51:10.262521 1 leaderelection.go:332] 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" E0410 03:51:14.065985 1 leaderelection.go:332] 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" E0410 03:51:16.453900 1 leaderelection.go:332] 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" I0410 03:51:18.795575 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0410 03:51:18.795874 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_719cf2aa-d8ef-48bd-ab4f-4c01d5ffe15f became leader" I0410 03:51:18.808444 1 shared_informer.go:311] Waiting for caches to sync for tokens I0410 03:51:18.880236 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0410 03:51:18.880527 1 endpoints_controller.go:177] "Starting endpoint controller" I0410 03:51:18.880562 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0410 03:51:18.909194 1 shared_informer.go:318] Caches are synced for tokens I0410 03:51:18.964882 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0410 03:51:18.965176 1 serviceaccounts_controller.go:111] "Starting service account controller" I0410 03:51:18.965219 1 shared_informer.go:311] Waiting for caches to sync for service account I0410 03:51:18.978602 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0410 03:51:18.978856 1 replica_set.go:214] "Starting controller" name="replicaset" I0410 03:51:18.978876 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0410 03:51:18.986342 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0410 03:51:18.986529 1 pv_protection_controller.go:78] "Starting PV protection controller" I0410 03:51:18.986591 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0410 03:51:19.057708 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0410 03:51:19.057814 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0410 03:51:19.057862 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0410 03:51:19.057918 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0410 03:51:19.058077 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0410 03:51:19.058128 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0410 03:51:19.058259 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0410 03:51:19.058368 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0410 03:51:19.058473 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0410 03:51:19.058565 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0410 03:51:19.058630 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0410 03:51:19.058740 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0410 03:51:19.058831 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0410 03:51:19.058912 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0410 03:51:19.059011 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0410 03:51:19.059090 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0410 03:51:19.059157 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0410 03:51:19.059201 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" W0410 03:51:19.059253 1 shared_informer.go:593] resyncPeriod 20h52m28.496492656s is smaller than resyncCheckPeriod 21h53m40.96272739s and the informer has already started. Changing it to 21h53m40.96272739s I0410 03:51:19.059370 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0410 03:51:19.059452 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0410 03:51:19.059499 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0410 03:51:19.059575 1 resource_quota_controller.go:294] "Starting resource quota controller" I0410 03:51:19.059666 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0410 03:51:19.059812 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0410 03:51:19.118766 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0410 03:51:19.118986 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0410 03:51:19.119018 1 shared_informer.go:311] Waiting for caches to sync for deployment I0410 03:51:19.163405 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0410 03:51:19.163496 1 horizontal.go:200] "Starting HPA controller" I0410 03:51:19.163514 1 shared_informer.go:311] Waiting for caches to sync for HPA I0410 03:51:19.228219 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0410 03:51:19.228420 1 disruption.go:433] "Sending events to api server." I0410 03:51:19.228706 1 disruption.go:444] "Starting disruption controller" I0410 03:51:19.228767 1 shared_informer.go:311] Waiting for caches to sync for disruption I0410 03:51:19.239162 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0410 03:51:19.239338 1 cleaner.go:83] "Starting CSR cleaner controller" I0410 03:51:19.246896 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0410 03:51:19.247035 1 tokencleaner.go:112] "Starting token cleaner controller" I0410 03:51:19.247215 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0410 03:51:19.247230 1 shared_informer.go:318] Caches are synced for token_cleaner I0410 03:51:19.360952 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0410 03:51:19.361025 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0410 03:51:19.361094 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0410 03:51:19.608925 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0410 03:51:19.608994 1 namespace_controller.go:197] "Starting namespace controller" I0410 03:51:19.609134 1 shared_informer.go:311] Waiting for caches to sync for namespace I0410 03:51:19.849679 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0410 03:51:19.849715 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0410 03:51:19.849729 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0410 03:51:19.849762 1 graph_builder.go:294] "Running" component="GraphBuilder" I0410 03:51:20.101349 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0410 03:51:20.101467 1 daemon_controller.go:291] "Starting daemon sets controller" I0410 03:51:20.101479 1 shared_informer.go:311] Waiting for caches to sync for daemon sets E0410 03:51:20.253693 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0410 03:51:20.253724 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0410 03:51:20.401778 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0410 03:51:20.401855 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0410 03:51:20.401863 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0410 03:51:20.552009 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0410 03:51:20.552121 1 stateful_set.go:163] "Starting stateful set controller" I0410 03:51:20.552131 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0410 03:51:20.700835 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0410 03:51:20.700963 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0410 03:51:20.700982 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0410 03:51:21.091041 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0410 03:51:21.091124 1 ttl_controller.go:124] "Starting TTL controller" I0410 03:51:21.091160 1 shared_informer.go:311] Waiting for caches to sync for TTL I0410 03:51:21.101143 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0410 03:51:21.101172 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0410 03:51:21.101182 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0410 03:51:21.101202 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0410 03:51:21.173525 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0410 03:51:21.173642 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0410 03:51:21.173656 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0410 03:51:21.404591 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0410 03:51:21.404740 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0410 03:51:21.404784 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0410 03:51:21.822633 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0410 03:51:21.822853 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0410 03:51:21.822862 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0410 03:51:21.902177 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0410 03:51:21.902271 1 gc_controller.go:101] "Starting GC controller" I0410 03:51:21.902319 1 shared_informer.go:311] Waiting for caches to sync for GC I0410 03:51:22.828267 1 controllermanager.go:642] "Started controller" controller="job-controller" I0410 03:51:22.828368 1 job_controller.go:226] "Starting job controller" I0410 03:51:22.828389 1 shared_informer.go:311] Waiting for caches to sync for job I0410 03:51:22.831532 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0410 03:51:22.831557 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0410 03:51:22.831735 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0410 03:51:22.831759 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0410 03:51:24.527002 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0410 03:51:24.527279 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0410 03:51:24.527334 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0410 03:51:24.532074 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0410 03:51:24.532126 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0410 03:51:24.532171 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0410 03:51:24.532250 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0410 03:51:24.532287 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0410 03:51:24.532291 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0410 03:51:24.532531 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0410 03:51:24.532546 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0410 03:51:24.532734 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0410 03:51:24.532751 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0410 03:51:24.532894 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0410 03:51:24.532912 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0410 03:51:24.532942 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" E0410 03:51:25.777251 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0410 03:51:25.777341 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0410 03:51:25.873149 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0410 03:51:25.873275 1 attach_detach_controller.go:337] "Starting attach detach controller" I0410 03:51:25.873297 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0410 03:51:25.928620 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0410 03:51:25.928920 1 publisher.go:102] "Starting root CA cert publisher controller" I0410 03:51:25.929059 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0410 03:51:25.941327 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0410 03:51:25.941383 1 controller.go:169] "Starting ephemeral volume controller" I0410 03:51:25.941510 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0410 03:51:25.944649 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0410 03:51:25.944722 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0410 03:51:25.944877 1 node_lifecycle_controller.go:465] "Sending events to api server" I0410 03:51:25.944921 1 node_lifecycle_controller.go:476] "Starting node controller" I0410 03:51:25.944930 1 shared_informer.go:311] Waiting for caches to sync for taint I0410 03:51:25.999564 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0410 03:51:25.999887 1 pv_controller_base.go:319] "Starting persistent volume controller" I0410 03:51:25.999933 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0410 03:51:26.047657 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0410 03:51:26.047765 1 expand_controller.go:328] "Starting expand controller" I0410 03:51:26.047785 1 shared_informer.go:311] Waiting for caches to sync for expand I0410 03:51:26.053370 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0410 03:51:26.066625 1 shared_informer.go:318] Caches are synced for service account I0410 03:51:26.070189 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0410 03:51:26.073952 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0410 03:51:26.086931 1 shared_informer.go:318] Caches are synced for PV protection I0410 03:51:26.101729 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0410 03:51:26.101737 1 shared_informer.go:318] Caches are synced for cronjob I0410 03:51:26.102285 1 shared_informer.go:318] Caches are synced for TTL after finished I0410 03:51:26.109591 1 shared_informer.go:318] Caches are synced for namespace I0410 03:51:26.123652 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0410 03:51:26.130108 1 shared_informer.go:318] Caches are synced for crt configmap I0410 03:51:26.132360 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0410 03:51:26.132375 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0410 03:51:26.132497 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0410 03:51:26.132614 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0410 03:51:26.133565 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0410 03:51:26.148259 1 shared_informer.go:318] Caches are synced for expand I0410 03:51:26.153889 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" I0410 03:51:26.191272 1 shared_informer.go:318] Caches are synced for TTL I0410 03:51:26.204882 1 shared_informer.go:318] Caches are synced for endpoint_slice I0410 03:51:26.219077 1 shared_informer.go:318] Caches are synced for deployment I0410 03:51:26.228341 1 shared_informer.go:318] Caches are synced for PVC protection I0410 03:51:26.228470 1 shared_informer.go:318] Caches are synced for job I0410 03:51:26.229504 1 shared_informer.go:318] Caches are synced for disruption I0410 03:51:26.241858 1 shared_informer.go:318] Caches are synced for ephemeral I0410 03:51:26.245057 1 shared_informer.go:318] Caches are synced for taint I0410 03:51:26.245246 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0410 03:51:26.245251 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0410 03:51:26.245438 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0410 03:51:26.245444 1 taint_manager.go:210] "Sending events to api server" I0410 03:51:26.245572 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0410 03:51:26.245611 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" I0410 03:51:26.252229 1 shared_informer.go:318] Caches are synced for stateful set I0410 03:51:26.259856 1 shared_informer.go:318] Caches are synced for resource quota I0410 03:51:26.262184 1 shared_informer.go:318] Caches are synced for ReplicationController I0410 03:51:26.266277 1 shared_informer.go:318] Caches are synced for HPA I0410 03:51:26.273511 1 shared_informer.go:318] Caches are synced for attach detach I0410 03:51:26.279695 1 shared_informer.go:318] Caches are synced for ReplicaSet I0410 03:51:26.280825 1 shared_informer.go:318] Caches are synced for endpoint I0410 03:51:26.300735 1 shared_informer.go:318] Caches are synced for persistent volume I0410 03:51:26.302059 1 shared_informer.go:318] Caches are synced for daemon sets I0410 03:51:26.303408 1 shared_informer.go:318] Caches are synced for GC I0410 03:51:26.315852 1 event.go:307] "Event occurred" object="kube-system/coredns" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set coredns-7c96b6546b to 2" I0410 03:51:26.354005 1 shared_informer.go:318] Caches are synced for resource quota I0410 03:51:26.473085 1 event.go:307] "Event occurred" object="kube-system/coredns-7c96b6546b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-7c96b6546b-gh9kt" I0410 03:51:26.473306 1 event.go:307] "Event occurred" object="kube-system/kube-proxy" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: kube-proxy-nm6lb" I0410 03:51:26.500710 1 event.go:307] "Event occurred" object="kube-system/coredns-7c96b6546b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-7c96b6546b-8l6tb" I0410 03:51:26.566378 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="250.774024ms" I0410 03:51:26.591700 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="25.250117ms" I0410 03:51:26.591810 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="56.28µs" I0410 03:51:26.670514 1 shared_informer.go:318] Caches are synced for garbage collector I0410 03:51:26.750854 1 shared_informer.go:318] Caches are synced for garbage collector I0410 03:51:26.750902 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0410 03:51:27.111364 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="92.192µs" I0410 03:51:27.145372 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="72.111µs" I0410 03:51:36.048207 1 event.go:307] "Event occurred" object="kube-system/coredns" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set coredns-67659f764b to 1" I0410 03:51:36.057657 1 event.go:307] "Event occurred" object="kube-system/coredns-67659f764b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-67659f764b-8dtwb" I0410 03:51:36.067331 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="20.484958ms" I0410 03:51:36.076745 1 event.go:307] "Event occurred" object="kube-system/coredns" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled down replica set coredns-7c96b6546b to 1 from 2" I0410 03:51:36.096330 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="28.903491ms" I0410 03:51:36.097206 1 event.go:307] "Event occurred" object="kube-system/coredns-7c96b6546b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulDelete" message="Deleted pod: coredns-7c96b6546b-gh9kt" I0410 03:51:36.099497 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="3.105072ms" I0410 03:51:36.110281 1 event.go:307] "Event occurred" object="kube-system/coredns" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set coredns-67659f764b to 2 from 1" I0410 03:51:36.110558 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="34.1774ms" I0410 03:51:36.116201 1 event.go:307] "Event occurred" object="kube-system/coredns-67659f764b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-67659f764b-89rkn" I0410 03:51:36.124111 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="13.410528ms" I0410 03:51:36.124223 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="80.642µs" I0410 03:51:36.127326 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="17.986595ms" I0410 03:51:36.136812 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="9.464641ms" I0410 03:51:36.136877 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="33.311µs" I0410 03:51:48.047520 1 event.go:307] "Event occurred" object="kube-system/cilium-operator" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set cilium-operator-869df985b8 to 1" I0410 03:51:48.053673 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-nwshn" I0410 03:51:48.058024 1 event.go:307] "Event occurred" object="kube-system/cilium-operator-869df985b8" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-operator-869df985b8-qjmmx" I0410 03:51:48.086093 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="39.074378ms" I0410 03:51:48.104024 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="17.759504ms" I0410 03:51:48.104149 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="80.932µs" I0410 03:51:48.131664 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="164.734µs" I0410 03:51:56.361577 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0410 03:51:56.361613 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0410 03:51:56.361632 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0410 03:51:56.361668 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0410 03:51:56.361690 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0410 03:51:56.361710 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0410 03:51:56.361732 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0410 03:51:56.361753 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0410 03:51:56.361773 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0410 03:51:56.361791 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0410 03:51:56.361810 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0410 03:51:56.361840 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0410 03:51:56.361863 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0410 03:51:56.361884 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0410 03:51:56.361904 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0410 03:51:56.361925 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0410 03:51:56.361956 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0410 03:51:56.361974 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0410 03:51:56.362134 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0410 03:51:56.689640 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0410 03:51:57.562476 1 shared_informer.go:318] Caches are synced for resource quota I0410 03:51:57.590598 1 shared_informer.go:318] Caches are synced for garbage collector I0410 03:52:02.149042 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:02.165438 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:02.165754 1 event.go:307] "Event occurred" object="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" fieldPath="" kind="Job" apiVersion="batch/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: envoy-gateway-gateway-helm-certgen-sr9d5" I0410 03:52:02.171430 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:02.175755 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:02.972815 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="134.843µs" I0410 03:52:03.721908 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="10.511363ms" I0410 03:52:03.722166 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="113.683µs" I0410 03:52:11.252734 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0410 03:52:12.428315 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="64.252µs" I0410 03:52:12.430580 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:12.446073 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="46.272µs" I0410 03:52:12.454667 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:15.061483 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="113.023µs" I0410 03:52:15.089805 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="13.600294ms" I0410 03:52:15.090062 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="115.093µs" I0410 03:52:18.075941 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:19.679034 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:20.084168 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:20.687751 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:22.088971 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:23.096948 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:23.106617 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:23.110923 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:23.111343 1 event.go:307] "Event occurred" object="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" fieldPath="" kind="Job" apiVersion="batch/v1" type="Normal" reason="Completed" message="Job completed" I0410 03:52:23.167777 1 event.go:307] "Event occurred" object="envoy-gateway-system/envoy-gateway" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set envoy-gateway-78446f96c9 to 1" I0410 03:52:23.174127 1 event.go:307] "Event occurred" object="envoy-gateway-system/envoy-gateway-78446f96c9" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: envoy-gateway-78446f96c9-srsp2" I0410 03:52:23.184474 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="17.484486ms" I0410 03:52:23.196388 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="11.856251ms" I0410 03:52:23.196560 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="69.292µs" I0410 03:52:23.204355 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="95.623µs" I0410 03:52:26.110371 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="100.762µs" I0410 03:52:26.492325 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="116.103µs" I0410 03:52:26.494676 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="49.932µs" I0410 03:52:26.510052 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="78.622µs" I0410 03:52:26.521037 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="80.091µs" I0410 03:52:27.569760 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0410 03:52:27.569821 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0410 03:52:27.569904 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0410 03:52:27.570483 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0410 03:52:27.602241 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0410 03:52:27.670685 1 shared_informer.go:318] Caches are synced for resource quota I0410 03:52:27.703424 1 shared_informer.go:318] Caches are synced for garbage collector I0410 03:52:28.118994 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="65.411µs" I0410 03:52:28.146931 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="11.572629ms" I0410 03:52:28.147397 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="183.274µs" I0410 03:52:28.157446 1 event.go:307] "Event occurred" object="kube-system/coredns" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled down replica set coredns-7c96b6546b to 0 from 1" I0410 03:52:28.160386 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="7.995137ms" I0410 03:52:28.160568 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="38.761µs" I0410 03:52:28.166993 1 event.go:307] "Event occurred" object="kube-system/coredns-7c96b6546b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulDelete" message="Deleted pod: coredns-7c96b6546b-8l6tb" I0410 03:52:28.177158 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="20.041846ms" I0410 03:52:28.187629 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="10.406662ms" I0410 03:52:28.187991 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="93.472µs" I0410 03:52:30.458149 1 event.go:307] "Event occurred" object="local-path-storage/local-path-provisioner" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set local-path-provisioner-679c578f5 to 1" I0410 03:52:30.466262 1 event.go:307] "Event occurred" object="local-path-storage/local-path-provisioner-679c578f5" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: local-path-provisioner-679c578f5-wm6hm" I0410 03:52:30.478612 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="21.051376ms" I0410 03:52:30.487304 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="8.585358ms" I0410 03:52:30.488646 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="1.242449ms" I0410 03:52:30.491343 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="48.372µs" I0410 03:52:33.149326 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="8.230378ms" I0410 03:52:33.149605 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="223.525µs" I0410 03:52:33.672074 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="147.124µs" I0410 03:52:34.150439 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="118.092µs" I0410 03:52:34.153616 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="52.931µs" I0410 03:52:34.427243 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="27.735611ms" I0410 03:52:34.427415 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="87.872µs" I0410 03:52:53.020550 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:52:53.054460 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0410 03:53:54.844487 1 event.go:307] "Event occurred" object="default/test-pvc" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="WaitForFirstConsumer" message="waiting for first consumer to be created before binding" I0410 03:53:55.541598 1 event.go:307] "Event occurred" object="default/test-pvc" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="ExternalProvisioning" message="Waiting for a volume to be created either by the external provisioner 'cluster.local/local-path-provisioner' or manually by the system administrator. If volume creation is delayed, please verify that the provisioner is running and correctly registered." I0410 03:53:56.307261 1 event.go:307] "Event occurred" object="default/test-pvc" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="ExternalProvisioning" message="Waiting for a volume to be created either by the external provisioner 'cluster.local/local-path-provisioner' or manually by the system administrator. If volume creation is delayed, please verify that the provisioner is running and correctly registered."