I0520 17:21:52.847339 1 serving.go:348] Generated self-signed cert in-memory I0520 17:21:53.225784 1 controllermanager.go:189] "Starting" version="v1.28.13" I0520 17:21:53.225805 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0520 17:21:53.227234 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0520 17:21:53.229765 1 secure_serving.go:213] Serving securely on [::]:10257 I0520 17:21:53.230476 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0520 17:21:53.230671 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0520 17:21:53.230716 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" E0520 17:21:53.842307 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" I0520 17:21:56.003538 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_93f70add-90b2-4c16-aece-e21a70167e38 became leader" I0520 17:21:56.003967 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0520 17:21:56.015084 1 shared_informer.go:311] Waiting for caches to sync for tokens I0520 17:21:56.025480 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0520 17:21:56.025673 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0520 17:21:56.025701 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0520 17:21:56.037986 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0520 17:21:56.038089 1 serviceaccounts_controller.go:111] "Starting service account controller" I0520 17:21:56.038114 1 shared_informer.go:311] Waiting for caches to sync for service account I0520 17:21:56.049257 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0520 17:21:56.049264 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0520 17:21:56.049284 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 17:21:56.049321 1 graph_builder.go:294] "Running" component="GraphBuilder" I0520 17:21:56.056247 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0520 17:21:56.056393 1 cleaner.go:83] "Starting CSR cleaner controller" I0520 17:21:56.063938 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0520 17:21:56.064059 1 expand_controller.go:328] "Starting expand controller" I0520 17:21:56.064079 1 shared_informer.go:311] Waiting for caches to sync for expand I0520 17:21:56.072504 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0520 17:21:56.072663 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0520 17:21:56.072692 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0520 17:21:56.079472 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0520 17:21:56.079644 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0520 17:21:56.079661 1 shared_informer.go:311] Waiting for caches to sync for deployment I0520 17:21:56.086053 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0520 17:21:56.086112 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0520 17:21:56.108617 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0520 17:21:56.108678 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0520 17:21:56.108781 1 node_lifecycle_controller.go:465] "Sending events to api server" I0520 17:21:56.108812 1 node_lifecycle_controller.go:476] "Starting node controller" I0520 17:21:56.108852 1 shared_informer.go:311] Waiting for caches to sync for taint I0520 17:21:56.115301 1 shared_informer.go:318] Caches are synced for tokens E0520 17:21:56.259646 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0520 17:21:56.259699 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0520 17:21:56.408678 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0520 17:21:56.408874 1 pv_controller_base.go:319] "Starting persistent volume controller" I0520 17:21:56.408946 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0520 17:21:56.559298 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0520 17:21:56.559423 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0520 17:21:56.559476 1 shared_informer.go:311] Waiting for caches to sync for PVC protection E0520 17:21:56.607644 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0520 17:21:56.607677 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0520 17:21:56.762763 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0520 17:21:56.762975 1 endpoints_controller.go:177] "Starting endpoint controller" I0520 17:21:56.762991 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0520 17:21:57.063474 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0520 17:21:57.063519 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0520 17:21:57.063550 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0520 17:21:57.063582 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0520 17:21:57.063626 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0520 17:21:57.063645 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0520 17:21:57.063670 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0520 17:21:57.063690 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0520 17:21:57.063703 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" W0520 17:21:57.063715 1 shared_informer.go:593] resyncPeriod 14h7m0.293738232s is smaller than resyncCheckPeriod 23h9m48.235847404s and the informer has already started. Changing it to 23h9m48.235847404s I0520 17:21:57.063766 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0520 17:21:57.063790 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0520 17:21:57.063818 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0520 17:21:57.063851 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0520 17:21:57.063876 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0520 17:21:57.063898 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0520 17:21:57.063917 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" W0520 17:21:57.063928 1 shared_informer.go:593] resyncPeriod 13h59m34.337901125s is smaller than resyncCheckPeriod 23h9m48.235847404s and the informer has already started. Changing it to 23h9m48.235847404s I0520 17:21:57.063975 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0520 17:21:57.064006 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0520 17:21:57.064026 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0520 17:21:57.064079 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0520 17:21:57.064108 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0520 17:21:57.064234 1 resource_quota_controller.go:294] "Starting resource quota controller" I0520 17:21:57.064318 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 17:21:57.064375 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0520 17:21:57.687716 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0520 17:21:57.688031 1 horizontal.go:200] "Starting HPA controller" I0520 17:21:57.688069 1 shared_informer.go:311] Waiting for caches to sync for HPA I0520 17:21:57.708755 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0520 17:21:57.709440 1 disruption.go:433] "Sending events to api server." I0520 17:21:57.709528 1 disruption.go:444] "Starting disruption controller" I0520 17:21:57.709543 1 shared_informer.go:311] Waiting for caches to sync for disruption I0520 17:21:57.719975 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0520 17:21:57.720054 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0520 17:21:57.720063 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0520 17:21:57.757795 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0520 17:21:57.757873 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0520 17:21:57.757904 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0520 17:21:57.912234 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0520 17:21:57.912337 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0520 17:21:57.912372 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0520 17:21:57.958543 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0520 17:21:57.958592 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0520 17:21:57.958604 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 17:21:57.959317 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0520 17:21:57.959343 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0520 17:21:57.959382 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 17:21:57.960055 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0520 17:21:57.960085 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0520 17:21:57.960150 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 17:21:57.960386 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0520 17:21:57.960506 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0520 17:21:57.960516 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0520 17:21:57.960575 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 17:21:58.108835 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0520 17:21:58.108923 1 tokencleaner.go:112] "Starting token cleaner controller" I0520 17:21:58.108934 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0520 17:21:58.108946 1 shared_informer.go:318] Caches are synced for token_cleaner I0520 17:21:58.259682 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0520 17:21:58.259952 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0520 17:21:58.259976 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0520 17:21:58.417479 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0520 17:21:58.417520 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0520 17:21:58.417547 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0520 17:21:58.417557 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0520 17:21:58.417651 1 daemon_controller.go:291] "Starting daemon sets controller" I0520 17:21:58.417665 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0520 17:21:58.561332 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0520 17:21:58.561518 1 controller.go:169] "Starting ephemeral volume controller" I0520 17:21:58.561616 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0520 17:21:58.711198 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0520 17:21:58.711420 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0520 17:21:58.711444 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0520 17:21:58.859848 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0520 17:21:58.859962 1 gc_controller.go:101] "Starting GC controller" I0520 17:21:58.860018 1 shared_informer.go:311] Waiting for caches to sync for GC I0520 17:21:59.009790 1 controllermanager.go:642] "Started controller" controller="job-controller" I0520 17:21:59.010030 1 job_controller.go:226] "Starting job controller" I0520 17:21:59.010074 1 shared_informer.go:311] Waiting for caches to sync for job I0520 17:21:59.160811 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0520 17:21:59.161105 1 stateful_set.go:163] "Starting stateful set controller" I0520 17:21:59.161157 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0520 17:21:59.310164 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0520 17:21:59.310234 1 pv_protection_controller.go:78] "Starting PV protection controller" I0520 17:21:59.310358 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0520 17:21:59.460458 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0520 17:21:59.460566 1 publisher.go:102] "Starting root CA cert publisher controller" I0520 17:21:59.460592 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0520 17:21:59.609903 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0520 17:21:59.609995 1 ttl_controller.go:124] "Starting TTL controller" I0520 17:21:59.610032 1 shared_informer.go:311] Waiting for caches to sync for TTL I0520 17:21:59.764369 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0520 17:21:59.764533 1 attach_detach_controller.go:337] "Starting attach detach controller" I0520 17:21:59.764557 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0520 17:22:00.017722 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0520 17:22:00.017781 1 namespace_controller.go:197] "Starting namespace controller" I0520 17:22:00.017805 1 shared_informer.go:311] Waiting for caches to sync for namespace I0520 17:22:00.159356 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0520 17:22:00.159620 1 replica_set.go:214] "Starting controller" name="replicaset" I0520 17:22:00.159691 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0520 17:22:00.177686 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 17:22:00.180514 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" I0520 17:22:00.186593 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0520 17:22:00.188113 1 shared_informer.go:318] Caches are synced for HPA I0520 17:22:00.189490 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 17:22:00.209199 1 shared_informer.go:318] Caches are synced for persistent volume I0520 17:22:00.209457 1 shared_informer.go:318] Caches are synced for taint I0520 17:22:00.209664 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0520 17:22:00.209868 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0520 17:22:00.209989 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0520 17:22:00.210124 1 shared_informer.go:318] Caches are synced for job I0520 17:22:00.210201 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0520 17:22:00.210290 1 taint_manager.go:210] "Sending events to api server" I0520 17:22:00.211400 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" I0520 17:22:00.211518 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0520 17:22:00.211533 1 shared_informer.go:318] Caches are synced for disruption I0520 17:22:00.211615 1 shared_informer.go:318] Caches are synced for TTL I0520 17:22:00.211633 1 shared_informer.go:318] Caches are synced for PV protection I0520 17:22:00.212880 1 shared_informer.go:318] Caches are synced for endpoint_slice I0520 17:22:00.218101 1 shared_informer.go:318] Caches are synced for daemon sets I0520 17:22:00.218161 1 shared_informer.go:318] Caches are synced for namespace I0520 17:22:00.220577 1 shared_informer.go:318] Caches are synced for cronjob I0520 17:22:00.225860 1 shared_informer.go:318] Caches are synced for ReplicationController I0520 17:22:00.238601 1 shared_informer.go:318] Caches are synced for service account I0520 17:22:00.258340 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0520 17:22:00.258703 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0520 17:22:00.261108 1 shared_informer.go:318] Caches are synced for crt configmap I0520 17:22:00.261148 1 shared_informer.go:318] Caches are synced for ReplicaSet I0520 17:22:00.261235 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0520 17:22:00.261123 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0520 17:22:00.261830 1 shared_informer.go:318] Caches are synced for PVC protection I0520 17:22:00.261884 1 shared_informer.go:318] Caches are synced for ephemeral I0520 17:22:00.261909 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0520 17:22:00.262012 1 shared_informer.go:318] Caches are synced for stateful set I0520 17:22:00.262041 1 shared_informer.go:318] Caches are synced for GC I0520 17:22:00.262116 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0520 17:22:00.264566 1 shared_informer.go:318] Caches are synced for expand I0520 17:22:00.264702 1 shared_informer.go:318] Caches are synced for endpoint I0520 17:22:00.272984 1 shared_informer.go:318] Caches are synced for TTL after finished I0520 17:22:00.280530 1 shared_informer.go:318] Caches are synced for deployment I0520 17:22:00.365078 1 shared_informer.go:318] Caches are synced for resource quota I0520 17:22:00.378346 1 shared_informer.go:318] Caches are synced for resource quota I0520 17:22:00.465519 1 shared_informer.go:318] Caches are synced for attach detach I0520 17:22:00.790780 1 shared_informer.go:318] Caches are synced for garbage collector I0520 17:22:00.824697 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" I0520 17:22:00.849799 1 shared_informer.go:318] Caches are synced for garbage collector I0520 17:22:00.849837 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0520 17:22:00.975984 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-rnphg" I0520 17:22:01.270634 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" I0520 17:22:01.370783 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-2mgmf" I0520 17:22:01.381550 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-5nvmd" I0520 17:22:01.395955 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="124.279463ms" I0520 17:22:01.407436 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="11.394572ms" I0520 17:22:01.422097 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="14.603177ms" I0520 17:22:01.422248 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="90.861µs" I0520 17:22:14.325287 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" I0520 17:22:14.333213 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-2gv8m" I0520 17:22:14.340328 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="15.647916ms" I0520 17:22:14.343920 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" I0520 17:22:14.356728 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-5nvmd" I0520 17:22:14.359926 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" I0520 17:22:14.361088 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="20.71107ms" E0520 17:22:14.361223 1 replica_set.go:557] sync "kube-system/coredns-67659f764b" failed with Operation cannot be fulfilled on replicasets.apps "coredns-67659f764b": the object has been modified; please apply your changes to the latest version and try again I0520 17:22:14.364735 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="21.239708ms" I0520 17:22:14.369280 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-s5zx2" I0520 17:22:14.372683 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="7.810638ms" I0520 17:22:14.372874 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="53.141µs" I0520 17:22:14.377585 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="16.190636ms" I0520 17:22:14.385291 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="6.977064ms" I0520 17:22:14.385471 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="133.532µs" I0520 17:22:26.992614 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" I0520 17:22:27.003184 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-24mfk" I0520 17:22:27.020214 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-9hjz4" I0520 17:22:27.056676 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="64.30936ms" I0520 17:22:27.083409 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="26.661555ms" I0520 17:22:27.084585 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="1.134141ms" I0520 17:22:27.128930 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="164.544µs" I0520 17:22:30.387405 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0520 17:22:30.387455 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0520 17:22:30.387481 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0520 17:22:30.387512 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0520 17:22:30.388002 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0520 17:22:30.388032 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0520 17:22:30.388091 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0520 17:22:30.388117 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0520 17:22:30.388140 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0520 17:22:30.388202 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0520 17:22:30.388264 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0520 17:22:30.388317 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0520 17:22:30.388344 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0520 17:22:30.388407 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0520 17:22:30.388526 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0520 17:22:30.388704 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 17:22:30.802967 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 17:22:31.289315 1 shared_informer.go:318] Caches are synced for resource quota I0520 17:22:31.503394 1 shared_informer.go:318] Caches are synced for garbage collector I0520 17:22:39.551902 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="172.194µs" I0520 17:22:39.613402 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="14.061266ms" I0520 17:22:39.613622 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="125.973µs" I0520 17:22:40.064444 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:40.087681 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:40.088876 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-9tt5r" I0520 17:22:40.095898 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:40.103448 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:43.372082 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="70.801µs" I0520 17:22:43.373541 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:43.387971 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="77.381µs" I0520 17:22:43.397461 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:45.216482 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0520 17:22:48.592741 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="135.993µs" I0520 17:22:48.616353 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="7.860701ms" I0520 17:22:48.616501 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="82.292µs" I0520 17:22:52.685047 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:54.698409 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:55.627011 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:55.709759 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:57.395306 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:58.407328 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:58.416050 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:58.425747 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" I0520 17:22:58.425838 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:22:58.490494 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" I0520 17:22:58.497423 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-r6lx7" I0520 17:22:58.507567 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="18.084056ms" I0520 17:22:58.529796 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="22.157042ms" I0520 17:22:58.530004 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="149.083µs" I0520 17:22:58.530070 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="31.78µs" I0520 17:22:58.534764 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="119.153µs" I0520 17:23:00.653648 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="150.653µs" I0520 17:23:01.297319 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0520 17:23:01.297374 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0520 17:23:01.297395 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0520 17:23:01.297418 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0520 17:23:01.297444 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0520 17:23:01.297465 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0520 17:23:01.297543 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 17:23:01.398595 1 shared_informer.go:318] Caches are synced for resource quota I0520 17:23:01.520776 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 17:23:01.621863 1 shared_informer.go:318] Caches are synced for garbage collector I0520 17:23:01.914038 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="152.103µs" I0520 17:23:01.917315 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="145.853µs" I0520 17:23:01.929370 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="96.672µs" I0520 17:23:01.941106 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="41.901µs" I0520 17:23:02.657364 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="95.442µs" I0520 17:23:03.706179 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="96.402µs" I0520 17:23:03.848107 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="108.46612ms" I0520 17:23:03.848486 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="303.776µs" I0520 17:23:03.933741 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" I0520 17:23:04.188794 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-2mgmf" I0520 17:23:04.274226 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="340.72839ms" I0520 17:23:04.300800 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="26.445516ms" I0520 17:23:04.301115 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="136.983µs" I0520 17:23:07.184458 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" I0520 17:23:07.212605 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-fhbpn" I0520 17:23:07.234555 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="51.03375ms" I0520 17:23:07.285301 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="50.664971ms" I0520 17:23:07.304817 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="19.10278ms" I0520 17:23:07.304969 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="90.242µs" I0520 17:23:09.137819 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="10.420659ms" I0520 17:23:09.137897 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="45.001µs" I0520 17:23:09.518274 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="57.672µs" I0520 17:23:09.984594 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="120.732µs" I0520 17:23:09.987204 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="46.852µs" I0520 17:23:10.708250 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="13.830256ms" I0520 17:23:10.708414 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="87.872µs" I0520 17:23:12.822649 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="29.727522ms" I0520 17:23:12.822975 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="265.736µs" I0520 17:23:28.019459 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:23:28.072353 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 17:24:34.019465 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" I0520 17:24:34.717920 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."