I0422 18:25:00.786480 1 serving.go:348] Generated self-signed cert in-memory I0422 18:25:01.060152 1 controllermanager.go:189] "Starting" version="v1.28.13" I0422 18:25:01.060174 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0422 18:25:01.061445 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0422 18:25:01.061442 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0422 18:25:01.061588 1 secure_serving.go:213] Serving securely on [::]:10257 I0422 18:25:01.061670 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0422 18:25:01.061833 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... E0422 18:25:02.688523 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" I0422 18:25:05.694439 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0422 18:25:05.694699 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_49b57b05-d3c0-4616-a85e-b312ee97aba7 became leader" I0422 18:25:05.705509 1 shared_informer.go:311] Waiting for caches to sync for tokens I0422 18:25:05.722601 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0422 18:25:05.722803 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0422 18:25:05.722829 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0422 18:25:05.731831 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0422 18:25:05.732079 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0422 18:25:05.732093 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0422 18:25:05.744391 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0422 18:25:05.744634 1 serviceaccounts_controller.go:111] "Starting service account controller" I0422 18:25:05.744650 1 shared_informer.go:311] Waiting for caches to sync for service account I0422 18:25:05.754333 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0422 18:25:05.754521 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0422 18:25:05.754533 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0422 18:25:05.754729 1 graph_builder.go:294] "Running" component="GraphBuilder" I0422 18:25:05.767595 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0422 18:25:05.767860 1 ttl_controller.go:124] "Starting TTL controller" I0422 18:25:05.767962 1 shared_informer.go:311] Waiting for caches to sync for TTL E0422 18:25:05.774111 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0422 18:25:05.774151 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0422 18:25:05.781388 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0422 18:25:05.781531 1 expand_controller.go:328] "Starting expand controller" I0422 18:25:05.781545 1 shared_informer.go:311] Waiting for caches to sync for expand I0422 18:25:05.793725 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0422 18:25:05.793937 1 endpoints_controller.go:177] "Starting endpoint controller" I0422 18:25:05.793952 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0422 18:25:05.799068 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0422 18:25:05.799087 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0422 18:25:05.799127 1 tokencleaner.go:112] "Starting token cleaner controller" I0422 18:25:05.799136 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0422 18:25:05.799141 1 shared_informer.go:318] Caches are synced for token_cleaner I0422 18:25:05.806392 1 shared_informer.go:318] Caches are synced for tokens I0422 18:25:05.848732 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0422 18:25:05.848805 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0422 18:25:05.848869 1 node_lifecycle_controller.go:465] "Sending events to api server" I0422 18:25:05.848905 1 node_lifecycle_controller.go:476] "Starting node controller" I0422 18:25:05.848914 1 shared_informer.go:311] Waiting for caches to sync for taint E0422 18:25:06.001389 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0422 18:25:06.001499 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0422 18:25:06.149479 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0422 18:25:06.149545 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0422 18:25:06.149556 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0422 18:25:06.149612 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0422 18:25:06.300790 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0422 18:25:06.300875 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0422 18:25:06.300888 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0422 18:25:06.452328 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0422 18:25:06.452422 1 gc_controller.go:101] "Starting GC controller" I0422 18:25:06.452439 1 shared_informer.go:311] Waiting for caches to sync for GC I0422 18:25:06.601567 1 controllermanager.go:642] "Started controller" controller="job-controller" I0422 18:25:06.601641 1 job_controller.go:226] "Starting job controller" I0422 18:25:06.601650 1 shared_informer.go:311] Waiting for caches to sync for job I0422 18:25:06.750416 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0422 18:25:06.750544 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0422 18:25:06.750743 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0422 18:25:06.751047 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0422 18:25:06.751079 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0422 18:25:06.751131 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0422 18:25:06.751718 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0422 18:25:06.751759 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0422 18:25:06.751848 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0422 18:25:06.752355 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0422 18:25:06.752456 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0422 18:25:06.752478 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0422 18:25:06.752511 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0422 18:25:06.901334 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0422 18:25:06.901540 1 daemon_controller.go:291] "Starting daemon sets controller" I0422 18:25:06.901573 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0422 18:25:07.051327 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0422 18:25:07.051977 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0422 18:25:07.052014 1 shared_informer.go:311] Waiting for caches to sync for deployment I0422 18:25:07.201530 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0422 18:25:07.201677 1 replica_set.go:214] "Starting controller" name="replicaset" I0422 18:25:07.201732 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0422 18:25:07.398929 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0422 18:25:07.399023 1 disruption.go:433] "Sending events to api server." I0422 18:25:07.399092 1 disruption.go:444] "Starting disruption controller" I0422 18:25:07.399113 1 shared_informer.go:311] Waiting for caches to sync for disruption I0422 18:25:07.448871 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0422 18:25:07.448965 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0422 18:25:07.448976 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0422 18:25:07.600006 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0422 18:25:07.600120 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0422 18:25:07.600134 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0422 18:25:07.749628 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0422 18:25:07.749834 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0422 18:25:07.749856 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0422 18:25:08.006660 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0422 18:25:08.006755 1 namespace_controller.go:197] "Starting namespace controller" I0422 18:25:08.006785 1 shared_informer.go:311] Waiting for caches to sync for namespace I0422 18:25:08.150360 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0422 18:25:08.150463 1 publisher.go:102] "Starting root CA cert publisher controller" I0422 18:25:08.150484 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0422 18:25:08.301234 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0422 18:25:08.301400 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0422 18:25:08.301475 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0422 18:25:08.607676 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0422 18:25:08.607741 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0422 18:25:08.607856 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0422 18:25:08.607968 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0422 18:25:08.608132 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0422 18:25:08.608208 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0422 18:25:08.608295 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0422 18:25:08.608399 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0422 18:25:08.608584 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0422 18:25:08.608679 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0422 18:25:08.608849 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0422 18:25:08.609026 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0422 18:25:08.609255 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0422 18:25:08.609377 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0422 18:25:08.609531 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0422 18:25:08.609627 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0422 18:25:08.609663 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0422 18:25:08.609735 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0422 18:25:08.609815 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0422 18:25:08.609855 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0422 18:25:08.609949 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0422 18:25:08.610062 1 resource_quota_controller.go:294] "Starting resource quota controller" I0422 18:25:08.610107 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0422 18:25:08.610148 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0422 18:25:08.751121 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0422 18:25:08.751345 1 controller.go:169] "Starting ephemeral volume controller" I0422 18:25:08.751367 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0422 18:25:09.048978 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0422 18:25:09.049068 1 horizontal.go:200] "Starting HPA controller" I0422 18:25:09.049310 1 shared_informer.go:311] Waiting for caches to sync for HPA I0422 18:25:09.201304 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0422 18:25:09.201632 1 pv_controller_base.go:319] "Starting persistent volume controller" I0422 18:25:09.201678 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0422 18:25:09.350628 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0422 18:25:09.350874 1 attach_detach_controller.go:337] "Starting attach detach controller" I0422 18:25:09.350917 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0422 18:25:09.504688 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0422 18:25:09.504823 1 pv_protection_controller.go:78] "Starting PV protection controller" I0422 18:25:09.504849 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0422 18:25:09.650393 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0422 18:25:09.650524 1 stateful_set.go:163] "Starting stateful set controller" I0422 18:25:09.650560 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0422 18:25:09.799601 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0422 18:25:09.799731 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0422 18:25:09.799745 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0422 18:25:09.847028 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0422 18:25:09.847066 1 cleaner.go:83] "Starting CSR cleaner controller" I0422 18:25:09.854303 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0422 18:25:09.872149 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0422 18:25:09.881677 1 shared_informer.go:318] Caches are synced for expand I0422 18:25:09.894492 1 shared_informer.go:318] Caches are synced for endpoint I0422 18:25:09.899316 1 shared_informer.go:318] Caches are synced for disruption I0422 18:25:09.900842 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0422 18:25:09.901032 1 shared_informer.go:318] Caches are synced for cronjob I0422 18:25:09.901162 1 shared_informer.go:318] Caches are synced for TTL after finished I0422 18:25:09.901925 1 shared_informer.go:318] Caches are synced for ReplicaSet I0422 18:25:09.901975 1 shared_informer.go:318] Caches are synced for job I0422 18:25:09.905609 1 shared_informer.go:318] Caches are synced for PV protection I0422 18:25:09.907845 1 shared_informer.go:318] Caches are synced for namespace I0422 18:25:09.923430 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0422 18:25:09.932625 1 shared_informer.go:318] Caches are synced for PVC protection I0422 18:25:09.945230 1 shared_informer.go:318] Caches are synced for service account I0422 18:25:09.949507 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0422 18:25:09.949652 1 shared_informer.go:318] Caches are synced for HPA I0422 18:25:09.950077 1 shared_informer.go:318] Caches are synced for ReplicationController I0422 18:25:09.951032 1 shared_informer.go:318] Caches are synced for stateful set I0422 18:25:09.951108 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0422 18:25:09.951167 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0422 18:25:09.952588 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0422 18:25:09.952611 1 shared_informer.go:318] Caches are synced for ephemeral I0422 18:25:09.952829 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0422 18:25:09.953018 1 shared_informer.go:318] Caches are synced for deployment I0422 18:25:10.003747 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" I0422 18:25:10.049350 1 shared_informer.go:318] Caches are synced for taint I0422 18:25:10.049518 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0422 18:25:10.049648 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0422 18:25:10.049686 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0422 18:25:10.049774 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" I0422 18:25:10.049780 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0422 18:25:10.049817 1 taint_manager.go:210] "Sending events to api server" I0422 18:25:10.049983 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0422 18:25:10.051786 1 shared_informer.go:318] Caches are synced for attach detach I0422 18:25:10.051996 1 shared_informer.go:318] Caches are synced for crt configmap I0422 18:25:10.052550 1 shared_informer.go:318] Caches are synced for GC I0422 18:25:10.055137 1 shared_informer.go:318] Caches are synced for resource quota I0422 18:25:10.068736 1 shared_informer.go:318] Caches are synced for TTL I0422 18:25:10.101577 1 shared_informer.go:318] Caches are synced for endpoint_slice I0422 18:25:10.101758 1 shared_informer.go:318] Caches are synced for persistent volume I0422 18:25:10.101716 1 shared_informer.go:318] Caches are synced for daemon sets I0422 18:25:10.110467 1 shared_informer.go:318] Caches are synced for resource quota I0422 18:25:10.454673 1 shared_informer.go:318] Caches are synced for garbage collector I0422 18:25:10.454722 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0422 18:25:10.473016 1 shared_informer.go:318] Caches are synced for garbage collector I0422 18:25:10.668869 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" I0422 18:25:10.971118 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-vcr7b" I0422 18:25:11.065897 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-vlxrq" I0422 18:25:11.075867 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-9vfph" I0422 18:25:11.091977 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="422.923363ms" I0422 18:25:11.112711 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="20.665855ms" I0422 18:25:11.112988 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="214.659µs" I0422 18:25:18.481709 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" I0422 18:25:18.493051 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-mzhvf" I0422 18:25:18.504665 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" I0422 18:25:18.506536 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="24.915302ms" I0422 18:25:18.514099 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="7.520892ms" I0422 18:25:18.514708 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="61.485µs" I0422 18:25:18.514800 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-vlxrq" I0422 18:25:18.522605 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="18.801891ms" I0422 18:25:18.530996 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="8.352994ms" I0422 18:25:18.531727 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="81.177µs" I0422 18:25:18.533936 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" I0422 18:25:18.541449 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-c56vt" I0422 18:25:18.553334 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="19.300334ms" I0422 18:25:18.565222 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="11.40599ms" I0422 18:25:18.582888 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="17.585445ms" I0422 18:25:18.583003 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="78.287µs" I0422 18:25:31.558613 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-m2cns" I0422 18:25:31.559382 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" I0422 18:25:31.575153 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-ljx5z" I0422 18:25:31.591295 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="32.897285ms" I0422 18:25:31.606909 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="15.535164ms" I0422 18:25:31.608047 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="221.818µs" I0422 18:25:31.614671 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="59.564µs" I0422 18:25:40.063751 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0422 18:25:40.063806 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0422 18:25:40.063844 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0422 18:25:40.063892 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0422 18:25:40.063932 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0422 18:25:40.063950 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0422 18:25:40.063974 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0422 18:25:40.064012 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0422 18:25:40.064055 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0422 18:25:40.064245 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0422 18:25:40.064278 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0422 18:25:40.064342 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0422 18:25:40.064382 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0422 18:25:40.064454 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0422 18:25:40.064490 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0422 18:25:40.064563 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0422 18:25:40.064604 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0422 18:25:40.064660 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0422 18:25:40.064968 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0422 18:25:40.487512 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0422 18:25:42.488233 1 shared_informer.go:318] Caches are synced for garbage collector I0422 18:25:42.565667 1 shared_informer.go:318] Caches are synced for resource quota I0422 18:25:43.851974 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:43.866864 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:43.866947 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-r4ps9" I0422 18:25:43.879200 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:43.879224 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:45.291468 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="158.179µs" I0422 18:25:45.317138 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="11.557277ms" I0422 18:25:45.318005 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="178.39µs" I0422 18:25:49.100936 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="100.376µs" I0422 18:25:49.103659 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:49.115986 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="106.216µs" I0422 18:25:49.129125 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:50.057655 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0422 18:25:55.376790 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="99.436µs" I0422 18:25:59.218439 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:59.373136 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:25:59.731038 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="11.315178ms" I0422 18:25:59.731371 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="111.637µs" I0422 18:26:01.382311 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:26:02.395206 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:26:02.407581 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:26:02.413732 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" I0422 18:26:02.413979 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:26:02.474655 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" I0422 18:26:02.481735 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-mnlks" I0422 18:26:02.492104 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="17.920771ms" I0422 18:26:02.504589 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="12.449142ms" I0422 18:26:02.504753 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="134.358µs" I0422 18:26:02.505388 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="70.215µs" I0422 18:26:04.395409 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="136.759µs" I0422 18:26:05.621592 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="140.418µs" I0422 18:26:05.621645 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="21.771µs" I0422 18:26:05.639355 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="71.214µs" I0422 18:26:05.647774 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="106.366µs" I0422 18:26:07.410608 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="109.336µs" I0422 18:26:07.433220 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="9.096745ms" I0422 18:26:07.433341 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="78.014µs" I0422 18:26:07.441345 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" I0422 18:26:07.447850 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="8.759154ms" I0422 18:26:07.448086 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="179.111µs" I0422 18:26:07.454045 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-9vfph" I0422 18:26:07.464221 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="23.005154ms" I0422 18:26:07.481854 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="17.576392ms" I0422 18:26:07.482057 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="153.399µs" I0422 18:26:09.603799 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" I0422 18:26:09.620654 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-2z6vl" I0422 18:26:09.630850 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="26.77551ms" I0422 18:26:09.642465 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="11.567928ms" I0422 18:26:09.642534 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="37.722µs" I0422 18:26:12.443274 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="7.914657ms" I0422 18:26:12.443362 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="43.013µs" I0422 18:26:12.504085 1 shared_informer.go:311] Waiting for caches to sync for garbage collector W0422 18:26:12.576114 1 shared_informer.go:593] resyncPeriod 18h45m45.752518501s is smaller than resyncCheckPeriod 21h1m19.226641135s and the informer has already started. Changing it to 21h1m19.226641135s I0422 18:26:12.576199 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" W0422 18:26:12.576251 1 shared_informer.go:593] resyncPeriod 19h5m34.071332431s is smaller than resyncCheckPeriod 21h1m19.226641135s and the informer has already started. Changing it to 21h1m19.226641135s I0422 18:26:12.576303 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" W0422 18:26:12.576354 1 shared_informer.go:593] resyncPeriod 14h54m18.229887358s is smaller than resyncCheckPeriod 21h1m19.226641135s and the informer has already started. Changing it to 21h1m19.226641135s I0422 18:26:12.576387 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0422 18:26:12.576458 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0422 18:26:12.576501 1 shared_informer.go:318] Caches are synced for resource quota I0422 18:26:12.614546 1 shared_informer.go:318] Caches are synced for garbage collector I0422 18:26:12.871474 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="122.687µs" I0422 18:26:13.122471 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="12.501922ms" I0422 18:26:13.123038 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="245.555µs" I0422 18:26:13.442980 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="66.564µs" I0422 18:26:13.446571 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="54.644µs" I0422 18:26:32.023512 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:26:32.051542 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0422 18:27:37.998938 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" I0422 18:27:38.734330 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." I0422 18:27:40.108553 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."