I0520 11:24:04.635263 1 serving.go:348] Generated self-signed cert in-memory I0520 11:24:05.278702 1 controllermanager.go:189] "Starting" version="v1.28.13" I0520 11:24:05.278727 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0520 11:24:05.280033 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0520 11:24:05.280107 1 secure_serving.go:213] Serving securely on [::]:10257 I0520 11:24:05.280256 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0520 11:24:05.280280 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0520 11:24:05.280505 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" E0520 11:24:06.036710 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" E0520 11:24:09.767431 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" E0520 11:24:12.264303 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" E0520 11:24:14.678026 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" E0520 11:24:17.961962 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" E0520 11:24:21.431146 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 11:24:24.746605 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0520 11:24:24.747051 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_f1f58874-e054-4e45-8fb4-56bbc1ff08d6 became leader" I0520 11:24:25.758149 1 shared_informer.go:311] Waiting for caches to sync for tokens I0520 11:24:25.859004 1 shared_informer.go:318] Caches are synced for tokens I0520 11:24:26.774395 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0520 11:24:26.774591 1 disruption.go:433] "Sending events to api server." I0520 11:24:26.774673 1 disruption.go:444] "Starting disruption controller" I0520 11:24:26.774705 1 shared_informer.go:311] Waiting for caches to sync for disruption I0520 11:24:26.836956 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0520 11:24:26.837319 1 pv_controller_base.go:319] "Starting persistent volume controller" I0520 11:24:26.837334 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0520 11:24:26.899984 1 controllermanager.go:642] "Started controller" controller="job-controller" I0520 11:24:26.900014 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0520 11:24:26.900138 1 job_controller.go:226] "Starting job controller" I0520 11:24:26.900157 1 shared_informer.go:311] Waiting for caches to sync for job I0520 11:24:26.916409 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0520 11:24:26.916486 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0520 11:24:26.916511 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0520 11:24:26.930960 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0520 11:24:26.931065 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0520 11:24:26.931181 1 node_lifecycle_controller.go:465] "Sending events to api server" I0520 11:24:26.931225 1 node_lifecycle_controller.go:476] "Starting node controller" I0520 11:24:26.931241 1 shared_informer.go:311] Waiting for caches to sync for taint E0520 11:24:26.933249 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0520 11:24:26.933297 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0520 11:24:27.044478 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0520 11:24:27.044688 1 expand_controller.go:328] "Starting expand controller" I0520 11:24:27.044725 1 shared_informer.go:311] Waiting for caches to sync for expand I0520 11:24:27.082924 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0520 11:24:27.083057 1 endpoints_controller.go:177] "Starting endpoint controller" I0520 11:24:27.083077 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0520 11:24:27.118836 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0520 11:24:27.119008 1 gc_controller.go:101] "Starting GC controller" I0520 11:24:27.119036 1 shared_informer.go:311] Waiting for caches to sync for GC I0520 11:24:27.205474 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0520 11:24:27.205561 1 serviceaccounts_controller.go:111] "Starting service account controller" I0520 11:24:27.205585 1 shared_informer.go:311] Waiting for caches to sync for service account I0520 11:24:27.231554 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0520 11:24:27.231609 1 publisher.go:102] "Starting root CA cert publisher controller" I0520 11:24:27.231630 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0520 11:24:27.247643 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0520 11:24:27.247961 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0520 11:24:27.247991 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0520 11:24:27.372816 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0520 11:24:27.372855 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0520 11:24:27.372875 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0520 11:24:27.372939 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" W0520 11:24:27.373012 1 shared_informer.go:593] resyncPeriod 12h45m26.396746748s is smaller than resyncCheckPeriod 23h50m5.146002202s and the informer has already started. Changing it to 23h50m5.146002202s I0520 11:24:27.373097 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0520 11:24:27.373126 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0520 11:24:27.373172 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0520 11:24:27.373205 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0520 11:24:27.373244 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0520 11:24:27.373350 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0520 11:24:27.373398 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0520 11:24:27.373431 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0520 11:24:27.373504 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0520 11:24:27.373528 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0520 11:24:27.373577 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0520 11:24:27.373604 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" W0520 11:24:27.373648 1 shared_informer.go:593] resyncPeriod 20h4m1.305428253s is smaller than resyncCheckPeriod 23h50m5.146002202s and the informer has already started. Changing it to 23h50m5.146002202s I0520 11:24:27.373695 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0520 11:24:27.373745 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0520 11:24:27.373773 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0520 11:24:27.373839 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0520 11:24:27.373868 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0520 11:24:27.373930 1 resource_quota_controller.go:294] "Starting resource quota controller" I0520 11:24:27.373961 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 11:24:27.373994 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0520 11:24:27.640526 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0520 11:24:27.640687 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0520 11:24:27.640716 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0520 11:24:27.643670 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0520 11:24:27.643741 1 cleaner.go:83] "Starting CSR cleaner controller" I0520 11:24:27.885244 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0520 11:24:27.885310 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0520 11:24:27.917345 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0520 11:24:27.917481 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0520 11:24:27.917537 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0520 11:24:27.937954 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0520 11:24:27.938224 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0520 11:24:27.938267 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0520 11:24:28.111588 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0520 11:24:28.111811 1 stateful_set.go:163] "Starting stateful set controller" I0520 11:24:28.111851 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0520 11:24:28.228105 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0520 11:24:28.228198 1 tokencleaner.go:112] "Starting token cleaner controller" I0520 11:24:28.228210 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0520 11:24:28.228221 1 shared_informer.go:318] Caches are synced for token_cleaner I0520 11:24:28.369520 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0520 11:24:28.369596 1 pv_protection_controller.go:78] "Starting PV protection controller" I0520 11:24:28.369622 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0520 11:24:28.661982 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0520 11:24:28.662168 1 controller.go:169] "Starting ephemeral volume controller" I0520 11:24:28.662186 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0520 11:24:28.854758 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0520 11:24:28.854795 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 11:24:28.854809 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0520 11:24:28.854833 1 graph_builder.go:294] "Running" component="GraphBuilder" I0520 11:24:29.055098 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0520 11:24:29.055409 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0520 11:24:29.055493 1 shared_informer.go:311] Waiting for caches to sync for deployment I0520 11:24:29.170337 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0520 11:24:29.170619 1 replica_set.go:214] "Starting controller" name="replicaset" I0520 11:24:29.170667 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0520 11:24:29.440395 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0520 11:24:29.440502 1 horizontal.go:200] "Starting HPA controller" I0520 11:24:29.440549 1 shared_informer.go:311] Waiting for caches to sync for HPA I0520 11:24:30.052834 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0520 11:24:30.052894 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0520 11:24:30.052913 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0520 11:24:30.053308 1 ttl_controller.go:124] "Starting TTL controller" I0520 11:24:30.053364 1 shared_informer.go:311] Waiting for caches to sync for TTL I0520 11:24:30.497775 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0520 11:24:30.498113 1 attach_detach_controller.go:337] "Starting attach detach controller" I0520 11:24:30.498132 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0520 11:24:31.005841 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0520 11:24:31.005967 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0520 11:24:31.006591 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0520 11:24:31.429694 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0520 11:24:31.429811 1 namespace_controller.go:197] "Starting namespace controller" I0520 11:24:31.429899 1 shared_informer.go:311] Waiting for caches to sync for namespace I0520 11:24:31.655080 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0520 11:24:31.655379 1 daemon_controller.go:291] "Starting daemon sets controller" I0520 11:24:31.655428 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0520 11:24:32.019147 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0520 11:24:32.019210 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0520 11:24:32.019248 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0520 11:24:32.327254 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0520 11:24:32.327329 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0520 11:24:32.327359 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0520 11:24:32.628113 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0520 11:24:32.628149 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 11:24:32.628172 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0520 11:24:32.628638 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0520 11:24:32.628657 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0520 11:24:32.628710 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 11:24:32.629006 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0520 11:24:32.629018 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0520 11:24:32.629032 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0520 11:24:32.629534 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0520 11:24:32.629600 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0520 11:24:32.629657 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0520 11:24:32.629677 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" E0520 11:24:32.696007 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0520 11:24:32.696046 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0520 11:24:32.701871 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 11:24:32.713729 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 11:24:32.717587 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0520 11:24:32.720333 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0520 11:24:32.726498 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 11:24:32.727449 1 shared_informer.go:318] Caches are synced for TTL after finished I0520 11:24:32.728602 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0520 11:24:32.728683 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0520 11:24:32.729649 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0520 11:24:32.729759 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0520 11:24:32.730818 1 shared_informer.go:318] Caches are synced for namespace I0520 11:24:32.732025 1 shared_informer.go:318] Caches are synced for taint I0520 11:24:32.732146 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0520 11:24:32.732165 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0520 11:24:32.732216 1 taint_manager.go:210] "Sending events to api server" I0520 11:24:32.732274 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 11:24:32.732283 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0520 11:24:32.732363 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0520 11:24:32.738860 1 shared_informer.go:318] Caches are synced for ReplicationController I0520 11:24:32.741093 1 shared_informer.go:318] Caches are synced for HPA I0520 11:24:32.741136 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0520 11:24:32.745307 1 shared_informer.go:318] Caches are synced for expand I0520 11:24:32.748719 1 shared_informer.go:318] Caches are synced for endpoint_slice I0520 11:24:32.754370 1 shared_informer.go:318] Caches are synced for TTL I0520 11:24:32.755711 1 shared_informer.go:318] Caches are synced for deployment I0520 11:24:32.755734 1 shared_informer.go:318] Caches are synced for daemon sets I0520 11:24:32.763175 1 shared_informer.go:318] Caches are synced for ephemeral I0520 11:24:32.771483 1 shared_informer.go:318] Caches are synced for ReplicaSet I0520 11:24:32.774763 1 shared_informer.go:318] Caches are synced for disruption I0520 11:24:32.783366 1 shared_informer.go:318] Caches are synced for endpoint I0520 11:24:32.800330 1 shared_informer.go:318] Caches are synced for job I0520 11:24:32.805943 1 shared_informer.go:318] Caches are synced for service account I0520 11:24:32.807164 1 shared_informer.go:318] Caches are synced for PVC protection I0520 11:24:32.812542 1 shared_informer.go:318] Caches are synced for stateful set I0520 11:24:32.816923 1 shared_informer.go:318] Caches are synced for cronjob I0520 11:24:32.819097 1 shared_informer.go:318] Caches are synced for GC I0520 11:24:32.832745 1 shared_informer.go:318] Caches are synced for crt configmap I0520 11:24:32.875301 1 shared_informer.go:318] Caches are synced for resource quota I0520 11:24:32.886357 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0520 11:24:32.902961 1 shared_informer.go:318] Caches are synced for resource quota I0520 11:24:32.937833 1 shared_informer.go:318] Caches are synced for persistent volume I0520 11:24:32.945074 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 11:24:32.969858 1 shared_informer.go:318] Caches are synced for PV protection I0520 11:24:32.999120 1 shared_informer.go:318] Caches are synced for attach detach I0520 11:24:33.328383 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-cmj2f" I0520 11:24:33.328481 1 shared_informer.go:318] Caches are synced for garbage collector I0520 11:24:33.355015 1 shared_informer.go:318] Caches are synced for garbage collector I0520 11:24:33.355062 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0520 11:24:33.547829 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-c5fp8" I0520 11:24:33.645149 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-j82pd" I0520 11:24:33.710546 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="766.700337ms" I0520 11:24:33.722438 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="11.822858ms" I0520 11:24:33.722586 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="99.432µs" I0520 11:24:44.935649 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 11:24:44.964953 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-2jwts" I0520 11:24:44.973268 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="38.034734ms" I0520 11:24:44.976653 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 11:24:44.981074 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="7.751376ms" I0520 11:24:44.989468 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-c5fp8" I0520 11:24:44.993102 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 11:24:44.995926 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="14.784908ms" E0520 11:24:44.995953 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 11:24:45.003986 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-sqw74" I0520 11:24:45.004307 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="28.943121ms" I0520 11:24:45.014392 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="18.387828ms" I0520 11:24:45.019369 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="14.982859ms" I0520 11:24:45.019662 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="153.763µs" I0520 11:24:45.021579 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="7.138333ms" I0520 11:24:45.021853 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="59.991µs" I0520 11:24:46.788255 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="60.591µs" I0520 11:24:46.801472 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="56.511µs" I0520 11:24:46.810864 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="54.301µs" I0520 11:24:57.517544 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 11:24:57.579702 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-cbcmb" I0520 11:24:57.737614 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-2jhln" I0520 11:24:57.988617 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="471.435134ms" I0520 11:24:58.031722 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="43.034725ms" I0520 11:24:58.031822 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="72.271µs" I0520 11:24:58.083086 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="116.352µs" I0520 11:25:02.911463 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0520 11:25:02.911508 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0520 11:25:02.911538 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0520 11:25:02.911567 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0520 11:25:02.911595 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0520 11:25:02.911624 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0520 11:25:02.911650 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0520 11:25:02.911675 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0520 11:25:02.911697 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0520 11:25:02.911784 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 11:25:03.340322 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 11:25:03.614704 1 shared_informer.go:318] Caches are synced for resource quota I0520 11:25:03.640994 1 shared_informer.go:318] Caches are synced for garbage collector I0520 11:25:18.320690 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:18.367194 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:18.367562 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-259kn" I0520 11:25:18.389470 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:18.389715 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:18.821168 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="14.374102ms" I0520 11:25:18.821312 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="83.941µs" I0520 11:25:23.526583 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:23.527996 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="75.621µs" I0520 11:25:23.538603 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:23.551798 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="75.471µs" I0520 11:25:27.741091 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0520 11:25:28.911875 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="81.211µs" I0520 11:25:28.935027 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="8.845565ms" I0520 11:25:28.935169 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="89.012µs" I0520 11:25:31.849526 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:33.621888 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0520 11:25:33.622221 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0520 11:25:33.622449 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0520 11:25:33.622754 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0520 11:25:33.622996 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0520 11:25:33.623175 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0520 11:25:33.623327 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0520 11:25:33.623435 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0520 11:25:33.623542 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0520 11:25:33.623631 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0520 11:25:33.623714 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0520 11:25:33.623801 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0520 11:25:33.623994 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0520 11:25:33.660239 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0520 11:25:35.081979 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:35.125203 1 shared_informer.go:318] Caches are synced for resource quota I0520 11:25:35.160583 1 shared_informer.go:318] Caches are synced for garbage collector I0520 11:25:35.865106 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:36.095955 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:37.876935 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:38.888377 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:38.899033 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:38.905065 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 11:25:38.905182 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:25:38.977382 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 11:25:38.985308 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-ljpw2" I0520 11:25:39.000503 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="23.745527ms" I0520 11:25:39.026414 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="25.848607ms" I0520 11:25:39.026551 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="88.461µs" I0520 11:25:39.890024 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="96.801µs" I0520 11:25:42.276720 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="67.971µs" I0520 11:25:42.284859 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="50.31µs" I0520 11:25:42.300666 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="84.771µs" I0520 11:25:42.312164 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="56.501µs" I0520 11:25:43.902425 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="108.561µs" I0520 11:25:43.942592 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="15.212919ms" I0520 11:25:43.942768 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="113.932µs" I0520 11:25:43.955213 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 11:25:43.974088 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="27.581965ms" I0520 11:25:43.974308 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="78.701µs" I0520 11:25:43.984683 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-j82pd" I0520 11:25:44.004568 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="49.519979ms" I0520 11:25:44.032049 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="27.256979ms" I0520 11:25:44.032338 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="70.851µs" I0520 11:25:47.665429 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 11:25:47.687658 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-zv94g" I0520 11:25:47.700330 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="35.269167ms" I0520 11:25:47.709687 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="9.302691ms" I0520 11:25:47.709774 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="47.371µs" I0520 11:25:47.712879 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="48.12µs" I0520 11:25:49.281041 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="82.431µs" I0520 11:25:49.339237 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="13.884924ms" I0520 11:25:49.339692 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="174.672µs" I0520 11:25:49.937649 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="120.191µs" I0520 11:25:49.940776 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="96.311µs" I0520 11:25:50.945528 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="11.219966ms" I0520 11:25:50.945954 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="79.211µs" I0520 11:26:08.233412 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:26:08.620012 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0520 11:27:12.325439 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 11:27:12.969599 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." I0520 11:27:17.944417 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."