I0912 01:00:40.291839 1 serving.go:348] Generated self-signed cert in-memory I0912 01:00:40.579225 1 controllermanager.go:189] "Starting" version="v1.28.13" I0912 01:00:40.579256 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0912 01:00:40.580923 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0912 01:00:40.580993 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0912 01:00:40.581526 1 secure_serving.go:213] Serving securely on [::]:10257 I0912 01:00:40.581662 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0912 01:00:40.581811 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... E0912 01:00:42.448725 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" I0912 01:00:45.592579 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0912 01:00:45.593260 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_e46e8de5-b526-4f0c-afb2-ab2d251c2c42 became leader" I0912 01:00:45.602118 1 shared_informer.go:311] Waiting for caches to sync for tokens I0912 01:00:45.613813 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0912 01:00:45.613926 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0912 01:00:45.613948 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0912 01:00:45.622889 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0912 01:00:45.623107 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0912 01:00:45.623127 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0912 01:00:45.631622 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0912 01:00:45.631916 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0912 01:00:45.631949 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0912 01:00:45.640043 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0912 01:00:45.640073 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0912 01:00:45.640165 1 tokencleaner.go:112] "Starting token cleaner controller" I0912 01:00:45.640205 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0912 01:00:45.640250 1 shared_informer.go:318] Caches are synced for token_cleaner E0912 01:00:45.652170 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0912 01:00:45.652202 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0912 01:00:45.666272 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0912 01:00:45.666422 1 attach_detach_controller.go:337] "Starting attach detach controller" I0912 01:00:45.666449 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0912 01:00:45.676325 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0912 01:00:45.676631 1 endpoints_controller.go:177] "Starting endpoint controller" I0912 01:00:45.676730 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0912 01:00:45.685901 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0912 01:00:45.686104 1 gc_controller.go:101] "Starting GC controller" I0912 01:00:45.686120 1 shared_informer.go:311] Waiting for caches to sync for GC I0912 01:00:45.697730 1 controllermanager.go:642] "Started controller" controller="job-controller" I0912 01:00:45.697865 1 job_controller.go:226] "Starting job controller" I0912 01:00:45.697889 1 shared_informer.go:311] Waiting for caches to sync for job I0912 01:00:45.702261 1 shared_informer.go:318] Caches are synced for tokens I0912 01:00:45.706690 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0912 01:00:45.706756 1 expand_controller.go:328] "Starting expand controller" I0912 01:00:45.706806 1 shared_informer.go:311] Waiting for caches to sync for expand I0912 01:00:45.798732 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0912 01:00:45.798846 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0912 01:00:45.798868 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0912 01:00:45.948229 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0912 01:00:45.948357 1 pv_protection_controller.go:78] "Starting PV protection controller" I0912 01:00:45.948370 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0912 01:00:46.098592 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0912 01:00:46.098671 1 controller.go:169] "Starting ephemeral volume controller" I0912 01:00:46.098698 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0912 01:00:46.248328 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0912 01:00:46.248489 1 daemon_controller.go:291] "Starting daemon sets controller" I0912 01:00:46.248508 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0912 01:00:46.446420 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0912 01:00:46.446494 1 disruption.go:433] "Sending events to api server." I0912 01:00:46.446528 1 disruption.go:444] "Starting disruption controller" I0912 01:00:46.446538 1 shared_informer.go:311] Waiting for caches to sync for disruption I0912 01:00:46.601342 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0912 01:00:46.601428 1 ttl_controller.go:124] "Starting TTL controller" I0912 01:00:46.601457 1 shared_informer.go:311] Waiting for caches to sync for TTL E0912 01:00:46.749214 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0912 01:00:46.749253 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0912 01:00:46.898662 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0912 01:00:46.898983 1 pv_controller_base.go:319] "Starting persistent volume controller" I0912 01:00:46.899073 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0912 01:00:47.051654 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0912 01:00:47.052134 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0912 01:00:47.052166 1 shared_informer.go:311] Waiting for caches to sync for deployment I0912 01:00:47.202506 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0912 01:00:47.202633 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0912 01:00:47.202655 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0912 01:00:47.347979 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0912 01:00:47.348045 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0912 01:00:47.498995 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0912 01:00:47.499132 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0912 01:00:47.499161 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0912 01:00:47.648610 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0912 01:00:47.648714 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0912 01:00:47.648733 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0912 01:00:47.799024 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0912 01:00:47.799096 1 publisher.go:102] "Starting root CA cert publisher controller" I0912 01:00:47.799107 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0912 01:00:48.061386 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0912 01:00:48.061511 1 namespace_controller.go:197] "Starting namespace controller" I0912 01:00:48.061530 1 shared_informer.go:311] Waiting for caches to sync for namespace I0912 01:00:48.201827 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0912 01:00:48.201937 1 replica_set.go:214] "Starting controller" name="replicaset" I0912 01:00:48.201953 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0912 01:00:48.246995 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0912 01:00:48.247026 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0912 01:00:48.247055 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0912 01:00:48.247482 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0912 01:00:48.247598 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0912 01:00:48.247951 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0912 01:00:48.248001 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0912 01:00:48.248017 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0912 01:00:48.248033 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0912 01:00:48.248872 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0912 01:00:48.248939 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0912 01:00:48.248955 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0912 01:00:48.248981 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0912 01:00:48.295729 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0912 01:00:48.295787 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0912 01:00:48.295795 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0912 01:00:48.295857 1 cleaner.go:83] "Starting CSR cleaner controller" I0912 01:00:48.448321 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0912 01:00:48.448517 1 stateful_set.go:163] "Starting stateful set controller" I0912 01:00:48.448544 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0912 01:00:48.496960 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0912 01:00:48.497251 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0912 01:00:48.497445 1 node_lifecycle_controller.go:465] "Sending events to api server" I0912 01:00:48.497510 1 node_lifecycle_controller.go:476] "Starting node controller" I0912 01:00:48.497525 1 shared_informer.go:311] Waiting for caches to sync for taint I0912 01:00:48.647744 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0912 01:00:48.647889 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0912 01:00:48.647906 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0912 01:00:48.953264 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0912 01:00:48.953322 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0912 01:00:48.953402 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0912 01:00:48.953438 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0912 01:00:48.953603 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0912 01:00:48.953703 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0912 01:00:48.953817 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0912 01:00:48.953884 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0912 01:00:48.954023 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" W0912 01:00:48.954063 1 shared_informer.go:593] resyncPeriod 12h32m43.181922502s is smaller than resyncCheckPeriod 15h52m58.115691388s and the informer has already started. Changing it to 15h52m58.115691388s I0912 01:00:48.954322 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0912 01:00:48.954452 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0912 01:00:48.954545 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0912 01:00:48.954623 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0912 01:00:48.954745 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0912 01:00:48.954811 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0912 01:00:48.954886 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0912 01:00:48.954956 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0912 01:00:48.955034 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0912 01:00:48.955105 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0912 01:00:48.955215 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0912 01:00:48.955283 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0912 01:00:48.955403 1 resource_quota_controller.go:294] "Starting resource quota controller" I0912 01:00:48.955439 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0912 01:00:48.955468 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0912 01:00:49.097932 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0912 01:00:49.098144 1 serviceaccounts_controller.go:111] "Starting service account controller" I0912 01:00:49.098244 1 shared_informer.go:311] Waiting for caches to sync for service account I0912 01:00:49.347761 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0912 01:00:49.347804 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0912 01:00:49.347839 1 graph_builder.go:294] "Running" component="GraphBuilder" I0912 01:00:49.348106 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0912 01:00:49.746776 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0912 01:00:49.746877 1 horizontal.go:200] "Starting HPA controller" I0912 01:00:49.746991 1 shared_informer.go:311] Waiting for caches to sync for HPA I0912 01:00:49.750260 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0912 01:00:49.757436 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" I0912 01:00:49.761825 1 shared_informer.go:318] Caches are synced for namespace I0912 01:00:49.766578 1 shared_informer.go:318] Caches are synced for attach detach I0912 01:00:49.768623 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0912 01:00:49.777541 1 shared_informer.go:318] Caches are synced for endpoint I0912 01:00:49.786876 1 shared_informer.go:318] Caches are synced for GC I0912 01:00:49.799183 1 shared_informer.go:318] Caches are synced for PVC protection I0912 01:00:49.799217 1 shared_informer.go:318] Caches are synced for ReplicationController I0912 01:00:49.799235 1 shared_informer.go:318] Caches are synced for crt configmap I0912 01:00:49.799258 1 shared_informer.go:318] Caches are synced for persistent volume I0912 01:00:49.799338 1 shared_informer.go:318] Caches are synced for service account I0912 01:00:49.799360 1 shared_informer.go:318] Caches are synced for ephemeral I0912 01:00:49.801844 1 shared_informer.go:318] Caches are synced for TTL I0912 01:00:49.802713 1 shared_informer.go:318] Caches are synced for ReplicaSet I0912 01:00:49.807234 1 shared_informer.go:318] Caches are synced for expand I0912 01:00:49.814532 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0912 01:00:49.846637 1 shared_informer.go:318] Caches are synced for disruption I0912 01:00:49.848080 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0912 01:00:49.848109 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0912 01:00:49.848140 1 shared_informer.go:318] Caches are synced for HPA I0912 01:00:49.848228 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0912 01:00:49.848335 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0912 01:00:49.848465 1 shared_informer.go:318] Caches are synced for PV protection I0912 01:00:49.848606 1 shared_informer.go:318] Caches are synced for daemon sets I0912 01:00:49.848622 1 shared_informer.go:318] Caches are synced for stateful set I0912 01:00:49.848774 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0912 01:00:49.849276 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0912 01:00:49.852542 1 shared_informer.go:318] Caches are synced for deployment I0912 01:00:49.932358 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0912 01:00:49.948140 1 shared_informer.go:318] Caches are synced for endpoint_slice I0912 01:00:49.958139 1 shared_informer.go:318] Caches are synced for resource quota I0912 01:00:49.998167 1 shared_informer.go:318] Caches are synced for taint I0912 01:00:49.998267 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0912 01:00:49.998323 1 shared_informer.go:318] Caches are synced for job I0912 01:00:49.998366 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0912 01:00:49.998444 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0912 01:00:49.998474 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0912 01:00:49.998503 1 taint_manager.go:210] "Sending events to api server" I0912 01:00:49.998857 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" I0912 01:00:50.002741 1 shared_informer.go:318] Caches are synced for cronjob I0912 01:00:50.023595 1 shared_informer.go:318] Caches are synced for TTL after finished I0912 01:00:50.050507 1 shared_informer.go:318] Caches are synced for resource quota I0912 01:00:50.369248 1 shared_informer.go:318] Caches are synced for garbage collector I0912 01:00:50.448638 1 shared_informer.go:318] Caches are synced for garbage collector I0912 01:00:50.448726 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0912 01:00:50.717129 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-wvkk4" I0912 01:00:50.762120 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" I0912 01:00:50.861670 1 event.go:307] "Event occurred" object="kube-system/kube-vip-instance" fieldPath="" kind="Pod" apiVersion="v1" type="Warning" reason="NodeNotReady" message="Node is not ready" I0912 01:00:50.962145 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-vgrzc" I0912 01:00:50.974227 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-8t9kf" I0912 01:00:50.985147 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="222.707244ms" I0912 01:00:51.003528 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="18.311826ms" I0912 01:00:51.003766 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="167.249µs" I0912 01:00:51.003965 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="132.878µs" I0912 01:01:05.628975 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" I0912 01:01:05.637395 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-sqghg" I0912 01:01:05.649867 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="20.607892ms" I0912 01:01:05.658090 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" I0912 01:01:05.670084 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-vgrzc" I0912 01:01:05.671416 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="21.499705ms" I0912 01:01:05.671565 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="67.993µs" I0912 01:01:05.679799 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="21.999369ms" I0912 01:01:05.688941 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" I0912 01:01:05.696786 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="16.57207ms" I0912 01:01:05.696903 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="73.804µs" I0912 01:01:05.702175 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-tt6qs" I0912 01:01:05.718120 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="28.31783ms" I0912 01:01:05.727071 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="8.8188ms" I0912 01:01:05.727557 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="42.262µs" I0912 01:01:18.090390 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" I0912 01:01:18.109967 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-j7z4f" I0912 01:01:18.114935 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-27ptk" I0912 01:01:18.122659 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="33.235043ms" I0912 01:01:18.168790 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="45.651366ms" I0912 01:01:18.169069 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="235.76µs" I0912 01:01:20.382431 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0912 01:01:20.769540 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="116.546µs" I0912 01:01:20.806152 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="15.340787ms" I0912 01:01:20.806216 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="38.682µs" I0912 01:01:20.883571 1 shared_informer.go:318] Caches are synced for garbage collector I0912 01:01:26.502451 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:26.515445 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:26.515929 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-d9vcb" I0912 01:01:26.525426 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:26.525724 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:35.005605 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0912 01:01:38.814760 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="88.833µs" I0912 01:01:38.814907 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:38.835829 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="184.397µs" I0912 01:01:38.845777 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:40.865445 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="136.815µs" I0912 01:01:40.890665 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="11.833566ms" I0912 01:01:40.890788 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="74.403µs" I0912 01:01:45.035045 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:45.882482 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:47.889939 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:48.897680 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:48.908896 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:48.914281 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:01:48.915004 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" I0912 01:01:48.988123 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" I0912 01:01:49.004679 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-98p6x" I0912 01:01:49.019063 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="31.642016ms" I0912 01:01:49.038082 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="18.944283ms" I0912 01:01:49.038303 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="159.236µs" W0912 01:01:50.063102 1 shared_informer.go:593] resyncPeriod 14h56m18.993264425s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063195 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" W0912 01:01:50.063217 1 shared_informer.go:593] resyncPeriod 15h28m43.040362869s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063246 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" W0912 01:01:50.063263 1 shared_informer.go:593] resyncPeriod 13h27m45.384241537s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063285 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" W0912 01:01:50.063311 1 shared_informer.go:593] resyncPeriod 12h18m29.23083858s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063337 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0912 01:01:50.063384 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0912 01:01:50.063406 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0912 01:01:50.063426 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0912 01:01:50.063452 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0912 01:01:50.063494 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0912 01:01:50.063527 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0912 01:01:50.063549 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" W0912 01:01:50.063560 1 shared_informer.go:593] resyncPeriod 12h21m24.327600493s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063595 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0912 01:01:50.063635 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" W0912 01:01:50.063647 1 shared_informer.go:593] resyncPeriod 13h42m50.605937788s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063667 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0912 01:01:50.063729 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" W0912 01:01:50.063746 1 shared_informer.go:593] resyncPeriod 14h26m40.435376206s is smaller than resyncCheckPeriod 17h42m55.203286144s and the informer has already started. Changing it to 17h42m55.203286144s I0912 01:01:50.063764 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0912 01:01:50.063794 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0912 01:01:50.063818 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0912 01:01:50.063840 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0912 01:01:50.063862 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0912 01:01:50.063889 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0912 01:01:50.064140 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0912 01:01:50.896689 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0912 01:01:50.964371 1 shared_informer.go:318] Caches are synced for resource quota I0912 01:01:50.997919 1 shared_informer.go:318] Caches are synced for garbage collector I0912 01:01:51.906971 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="146.465µs" I0912 01:01:52.500560 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="104.723µs" I0912 01:01:52.506359 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="65.132µs" I0912 01:01:52.520779 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="43.121µs" I0912 01:01:52.537065 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="153.195µs" I0912 01:01:53.916689 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="93.443µs" I0912 01:01:53.943416 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="12.885262ms" I0912 01:01:53.943641 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="148.605µs" I0912 01:01:53.957572 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" I0912 01:01:53.962743 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="12.642984ms" I0912 01:01:53.963075 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="72.402µs" I0912 01:01:53.971549 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-8t9kf" I0912 01:01:53.981902 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="25.454505ms" I0912 01:01:53.994517 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="12.555182ms" I0912 01:01:53.994678 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="106.404µs" I0912 01:01:56.906798 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" I0912 01:01:56.919031 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-rm767" I0912 01:01:56.930461 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="23.87411ms" I0912 01:01:56.947605 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="17.065835ms" I0912 01:01:56.947718 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="58.971µs" I0912 01:01:59.295400 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="57.072µs" I0912 01:01:59.960500 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="9.834722ms" I0912 01:01:59.960589 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="47.541µs" I0912 01:01:59.967885 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="88.932µs" I0912 01:01:59.971781 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="79.023µs" I0912 01:02:00.848722 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="10.703847ms" I0912 01:02:00.848915 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="121.594µs" I0912 01:02:18.025388 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:02:18.068348 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0912 01:03:29.111828 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" I0912 01:03:29.730210 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." I0912 01:03:29.730748 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." I0912 01:03:34.807036 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."