I0916 21:38:35.352575 1 serving.go:348] Generated self-signed cert in-memory I0916 21:38:35.688238 1 controllermanager.go:189] "Starting" version="v1.28.13" I0916 21:38:35.688267 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0916 21:38:35.689844 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0916 21:38:35.689972 1 secure_serving.go:213] Serving securely on [::]:10257 I0916 21:38:35.690031 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0916 21:38:35.690159 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0916 21:38:35.690177 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... E0916 21:38:36.672468 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" I0916 21:38:39.257243 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0916 21:38:39.258184 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_9453da51-3706-4b13-a250-1eecf5fa0f1a became leader" I0916 21:38:39.268377 1 shared_informer.go:311] Waiting for caches to sync for tokens I0916 21:38:39.287357 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0916 21:38:39.287589 1 serviceaccounts_controller.go:111] "Starting service account controller" I0916 21:38:39.287607 1 shared_informer.go:311] Waiting for caches to sync for service account I0916 21:38:39.304571 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0916 21:38:39.304856 1 daemon_controller.go:291] "Starting daemon sets controller" I0916 21:38:39.304918 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0916 21:38:39.314880 1 controllermanager.go:642] "Started controller" controller="job-controller" I0916 21:38:39.315199 1 job_controller.go:226] "Starting job controller" I0916 21:38:39.315222 1 shared_informer.go:311] Waiting for caches to sync for job I0916 21:38:39.325199 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0916 21:38:39.325468 1 stateful_set.go:163] "Starting stateful set controller" I0916 21:38:39.325501 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0916 21:38:39.338637 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0916 21:38:39.339088 1 attach_detach_controller.go:337] "Starting attach detach controller" I0916 21:38:39.339145 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0916 21:38:39.347642 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0916 21:38:39.348008 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0916 21:38:39.348057 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0916 21:38:39.354911 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0916 21:38:39.355239 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0916 21:38:39.355277 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0916 21:38:39.362033 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0916 21:38:39.362436 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0916 21:38:39.362453 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0916 21:38:39.369099 1 shared_informer.go:318] Caches are synced for tokens I0916 21:38:39.371615 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0916 21:38:39.371706 1 publisher.go:102] "Starting root CA cert publisher controller" I0916 21:38:39.371724 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0916 21:38:39.404078 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0916 21:38:39.404196 1 ttl_controller.go:124] "Starting TTL controller" I0916 21:38:39.404236 1 shared_informer.go:311] Waiting for caches to sync for TTL I0916 21:38:39.464197 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0916 21:38:39.464297 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0916 21:38:39.464457 1 node_lifecycle_controller.go:465] "Sending events to api server" I0916 21:38:39.464569 1 node_lifecycle_controller.go:476] "Starting node controller" I0916 21:38:39.464583 1 shared_informer.go:311] Waiting for caches to sync for taint I0916 21:38:39.615097 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0916 21:38:39.615238 1 pv_controller_base.go:319] "Starting persistent volume controller" I0916 21:38:39.615302 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0916 21:38:39.769449 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0916 21:38:39.769505 1 controller.go:169] "Starting ephemeral volume controller" I0916 21:38:39.769532 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0916 21:38:39.916136 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0916 21:38:39.916456 1 gc_controller.go:101] "Starting GC controller" I0916 21:38:39.916487 1 shared_informer.go:311] Waiting for caches to sync for GC I0916 21:38:40.067109 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0916 21:38:40.067201 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0916 21:38:40.067498 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0916 21:38:40.067588 1 replica_set.go:214] "Starting controller" name="replicaset" I0916 21:38:40.067608 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0916 21:38:40.214015 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0916 21:38:40.214097 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0916 21:38:40.214134 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0916 21:38:40.365241 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0916 21:38:40.365279 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0916 21:38:40.365393 1 endpoints_controller.go:177] "Starting endpoint controller" I0916 21:38:40.365404 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0916 21:38:40.513135 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0916 21:38:40.513270 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0916 21:38:40.513286 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0916 21:38:40.671006 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0916 21:38:40.671071 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0916 21:38:40.671095 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0916 21:38:40.814265 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0916 21:38:40.814412 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0916 21:38:40.965977 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0916 21:38:40.966024 1 expand_controller.go:328] "Starting expand controller" I0916 21:38:40.966129 1 shared_informer.go:311] Waiting for caches to sync for expand I0916 21:38:41.161641 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0916 21:38:41.161721 1 disruption.go:433] "Sending events to api server." I0916 21:38:41.161783 1 disruption.go:444] "Starting disruption controller" I0916 21:38:41.161790 1 shared_informer.go:311] Waiting for caches to sync for disruption I0916 21:38:41.211248 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0916 21:38:41.211355 1 cleaner.go:83] "Starting CSR cleaner controller" I0916 21:38:41.417177 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0916 21:38:41.417391 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0916 21:38:41.417406 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0916 21:38:41.674650 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0916 21:38:41.674694 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0916 21:38:41.674727 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0916 21:38:41.674767 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0916 21:38:41.674799 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0916 21:38:41.674827 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0916 21:38:41.674857 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0916 21:38:41.674877 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0916 21:38:41.674901 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0916 21:38:41.674936 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0916 21:38:41.674951 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0916 21:38:41.674963 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0916 21:38:41.674990 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0916 21:38:41.675227 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0916 21:38:41.675374 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0916 21:38:41.675464 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" W0916 21:38:41.675738 1 shared_informer.go:593] resyncPeriod 19h16m30.026283272s is smaller than resyncCheckPeriod 20h54m31.658878203s and the informer has already started. Changing it to 20h54m31.658878203s I0916 21:38:41.675824 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" W0916 21:38:41.675841 1 shared_informer.go:593] resyncPeriod 15h13m9.027545367s is smaller than resyncCheckPeriod 20h54m31.658878203s and the informer has already started. Changing it to 20h54m31.658878203s I0916 21:38:41.675887 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0916 21:38:41.676015 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0916 21:38:41.676321 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0916 21:38:41.676370 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0916 21:38:41.676650 1 resource_quota_controller.go:294] "Starting resource quota controller" I0916 21:38:41.676665 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0916 21:38:41.676759 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0916 21:38:41.923720 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0916 21:38:41.923824 1 namespace_controller.go:197] "Starting namespace controller" I0916 21:38:41.923850 1 shared_informer.go:311] Waiting for caches to sync for namespace I0916 21:38:42.066734 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0916 21:38:42.066871 1 tokencleaner.go:112] "Starting token cleaner controller" I0916 21:38:42.066941 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0916 21:38:42.066962 1 shared_informer.go:318] Caches are synced for token_cleaner E0916 21:38:42.215070 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0916 21:38:42.215126 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0916 21:38:42.364191 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0916 21:38:42.364271 1 pv_protection_controller.go:78] "Starting PV protection controller" I0916 21:38:42.364305 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0916 21:38:42.610946 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0916 21:38:42.611223 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0916 21:38:42.611244 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0916 21:38:42.611272 1 graph_builder.go:294] "Running" component="GraphBuilder" I0916 21:38:42.864726 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0916 21:38:42.864828 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0916 21:38:42.864836 1 shared_informer.go:311] Waiting for caches to sync for deployment I0916 21:38:42.911565 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0916 21:38:42.911600 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0916 21:38:42.911637 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0916 21:38:42.912087 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0916 21:38:42.912117 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0916 21:38:42.912152 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0916 21:38:42.912513 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0916 21:38:42.912555 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0916 21:38:42.912602 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0916 21:38:42.912828 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0916 21:38:42.912894 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0916 21:38:42.912930 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0916 21:38:42.912963 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" E0916 21:38:42.961518 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0916 21:38:42.961554 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0916 21:38:43.262090 1 horizontal.go:200] "Starting HPA controller" I0916 21:38:43.262123 1 shared_informer.go:311] Waiting for caches to sync for HPA I0916 21:38:43.262155 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0916 21:38:43.412855 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0916 21:38:43.412987 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0916 21:38:43.413010 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0916 21:38:43.415788 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0916 21:38:43.425066 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" I0916 21:38:43.436300 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0916 21:38:43.455461 1 shared_informer.go:318] Caches are synced for endpoint_slice I0916 21:38:43.461887 1 shared_informer.go:318] Caches are synced for disruption I0916 21:38:43.463112 1 shared_informer.go:318] Caches are synced for ReplicationController I0916 21:38:43.465356 1 shared_informer.go:318] Caches are synced for deployment I0916 21:38:43.465391 1 shared_informer.go:318] Caches are synced for PV protection I0916 21:38:43.465421 1 shared_informer.go:318] Caches are synced for taint I0916 21:38:43.465559 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0916 21:38:43.465665 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0916 21:38:43.465747 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0916 21:38:43.465786 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0916 21:38:43.465844 1 taint_manager.go:210] "Sending events to api server" I0916 21:38:43.466147 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" I0916 21:38:43.466172 1 shared_informer.go:318] Caches are synced for endpoint I0916 21:38:43.468610 1 shared_informer.go:318] Caches are synced for ReplicaSet I0916 21:38:43.469722 1 shared_informer.go:318] Caches are synced for ephemeral I0916 21:38:43.471972 1 shared_informer.go:318] Caches are synced for crt configmap I0916 21:38:43.504569 1 shared_informer.go:318] Caches are synced for TTL I0916 21:38:43.505660 1 shared_informer.go:318] Caches are synced for daemon sets I0916 21:38:43.514894 1 shared_informer.go:318] Caches are synced for TTL after finished I0916 21:38:43.514942 1 shared_informer.go:318] Caches are synced for cronjob I0916 21:38:43.514959 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0916 21:38:43.515056 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0916 21:38:43.515351 1 shared_informer.go:318] Caches are synced for job I0916 21:38:43.515378 1 shared_informer.go:318] Caches are synced for persistent volume I0916 21:38:43.516617 1 shared_informer.go:318] Caches are synced for GC I0916 21:38:43.518449 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0916 21:38:43.524817 1 shared_informer.go:318] Caches are synced for namespace I0916 21:38:43.526078 1 shared_informer.go:318] Caches are synced for stateful set I0916 21:38:43.540527 1 shared_informer.go:318] Caches are synced for attach detach I0916 21:38:43.548939 1 shared_informer.go:318] Caches are synced for PVC protection I0916 21:38:43.567477 1 shared_informer.go:318] Caches are synced for expand I0916 21:38:43.577559 1 shared_informer.go:318] Caches are synced for resource quota I0916 21:38:43.587663 1 shared_informer.go:318] Caches are synced for service account I0916 21:38:43.616846 1 shared_informer.go:318] Caches are synced for resource quota I0916 21:38:43.662790 1 shared_informer.go:318] Caches are synced for HPA I0916 21:38:43.671693 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0916 21:38:43.711834 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0916 21:38:43.712687 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0916 21:38:43.712702 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0916 21:38:43.713978 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0916 21:38:43.975833 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" I0916 21:38:44.036568 1 shared_informer.go:318] Caches are synced for garbage collector I0916 21:38:44.078091 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" I0916 21:38:44.111885 1 shared_informer.go:318] Caches are synced for garbage collector I0916 21:38:44.111982 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0916 21:38:44.286057 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-gj686" I0916 21:38:44.630838 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-9t5jc" I0916 21:38:44.643015 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-f2txb" I0916 21:38:44.654680 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="678.811635ms" I0916 21:38:44.667397 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="12.633373ms" I0916 21:38:44.692653 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="25.170864ms" I0916 21:38:44.692777 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="76.762µs" I0916 21:38:58.813718 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" I0916 21:38:58.821386 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-5ln6h" I0916 21:38:58.838602 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="25.216941ms" I0916 21:38:58.848138 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" I0916 21:38:58.867987 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" I0916 21:38:58.869607 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="30.941089ms" E0916 21:38:58.869645 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 I0916 21:38:58.874834 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-9t5jc" I0916 21:38:58.880081 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-vdh5m" I0916 21:38:58.891619 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="21.790368ms" I0916 21:38:58.891871 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="43.415472ms" I0916 21:38:58.910067 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="18.386883ms" I0916 21:38:58.910415 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="18.448844ms" I0916 21:38:58.925630 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="15.134513ms" I0916 21:38:58.925803 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="120.582µs" I0916 21:38:58.928951 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="18.841442ms" I0916 21:38:58.929101 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="83.222µs" I0916 21:39:11.992131 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" I0916 21:39:12.003030 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-jsccq" I0916 21:39:12.003144 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-qmp2b" I0916 21:39:12.024420 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="32.282619ms" I0916 21:39:12.047989 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="23.422753ms" I0916 21:39:12.048496 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="424.367µs" I0916 21:39:12.049380 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="43.432µs" I0916 21:39:14.050609 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0916 21:39:14.150869 1 shared_informer.go:318] Caches are synced for garbage collector I0916 21:39:21.709560 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:21.734359 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:21.734700 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-qdhns" I0916 21:39:21.759804 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:21.761119 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:23.621797 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="20.946102ms" I0916 21:39:23.622071 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="208.767µs" I0916 21:39:27.429200 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:27.438710 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="97.813µs" I0916 21:39:27.454622 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:27.467625 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="146.385µs" I0916 21:39:28.474335 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0916 21:39:32.612191 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="98.393µs" I0916 21:39:32.644850 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="13.280964ms" I0916 21:39:32.645254 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="329.122µs" I0916 21:39:36.838398 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:37.645035 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:39.658759 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:40.681399 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:40.709022 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:40.759650 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:39:40.760844 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" I0916 21:39:41.121932 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" I0916 21:39:41.138622 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-sl85v" I0916 21:39:41.153764 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="32.283142ms" I0916 21:39:41.175595 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="21.755665ms" I0916 21:39:41.196747 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="21.071263ms" I0916 21:39:41.196927 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="116.933µs" I0916 21:39:42.678791 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="311.781µs" I0916 21:39:43.632669 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0916 21:39:43.632749 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0916 21:39:43.632801 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0916 21:39:43.633460 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0916 21:39:43.633535 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0916 21:39:43.633779 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0916 21:39:43.633853 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0916 21:39:43.633901 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0916 21:39:43.633947 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0916 21:39:43.634020 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0916 21:39:43.634159 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0916 21:39:43.634245 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0916 21:39:43.634299 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0916 21:39:43.634339 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0916 21:39:43.634390 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0916 21:39:43.634429 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0916 21:39:43.634471 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0916 21:39:43.634513 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0916 21:39:43.634558 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0916 21:39:43.634597 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0916 21:39:43.634642 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0916 21:39:43.634933 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0916 21:39:43.835541 1 shared_informer.go:318] Caches are synced for resource quota I0916 21:39:44.171729 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0916 21:39:44.272757 1 shared_informer.go:318] Caches are synced for garbage collector I0916 21:39:45.227432 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="201.106µs" I0916 21:39:45.235849 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="126.434µs" I0916 21:39:45.251634 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="126.584µs" I0916 21:39:45.266892 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="72.572µs" I0916 21:39:46.692014 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="105.093µs" I0916 21:39:46.727471 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="14.684597ms" I0916 21:39:46.727937 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="396.603µs" I0916 21:39:46.740665 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" I0916 21:39:46.744717 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="13.811341ms" I0916 21:39:46.744920 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="97.793µs" I0916 21:39:46.749932 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-f2txb" I0916 21:39:46.764767 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="24.255893ms" I0916 21:39:46.777624 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="12.792107ms" I0916 21:39:46.777935 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="70.252µs" I0916 21:39:49.709613 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" I0916 21:39:49.734947 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-v9h9p" I0916 21:39:49.749610 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="40.191608ms" I0916 21:39:49.764052 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="14.36439ms" I0916 21:39:49.764167 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="74.593µs" I0916 21:39:51.499050 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="14.685394ms" I0916 21:39:51.499227 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="129.084µs" I0916 21:39:52.120036 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="94.113µs" I0916 21:39:52.712794 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="47.751µs" I0916 21:39:52.720610 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="102.373µs" I0916 21:39:53.726905 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="9.725488ms" I0916 21:39:53.727191 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="217.088µs" I0916 21:40:10.022499 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:40:10.063875 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0916 21:41:22.332616 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" I0916 21:41:22.981288 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." I0916 21:41:22.981337 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."