I0918 22:55:01.334159 1 serving.go:348] Generated self-signed cert in-memory I0918 22:55:01.527911 1 controllermanager.go:189] "Starting" version="v1.28.13" I0918 22:55:01.527947 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0918 22:55:01.529768 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0918 22:55:01.530042 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0918 22:55:01.530137 1 secure_serving.go:213] Serving securely on [::]:10257 I0918 22:55:01.530213 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0918 22:55:01.530449 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... E0918 22:55:02.992211 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" I0918 22:55:05.266023 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0918 22:55:05.266437 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_999b163e-1743-4617-a0a3-66add661ecd7 became leader" I0918 22:55:06.284776 1 shared_informer.go:311] Waiting for caches to sync for tokens I0918 22:55:06.301332 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0918 22:55:06.301756 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0918 22:55:06.301828 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0918 22:55:06.320660 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0918 22:55:06.320925 1 expand_controller.go:328] "Starting expand controller" I0918 22:55:06.321021 1 shared_informer.go:311] Waiting for caches to sync for expand I0918 22:55:06.365946 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0918 22:55:06.366002 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0918 22:55:06.366022 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0918 22:55:06.366045 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0918 22:55:06.366099 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0918 22:55:06.366127 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0918 22:55:06.366219 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0918 22:55:06.366243 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0918 22:55:06.366305 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0918 22:55:06.366336 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" W0918 22:55:06.366347 1 shared_informer.go:593] resyncPeriod 19h32m45.821207406s is smaller than resyncCheckPeriod 23h41m56.447611141s and the informer has already started. Changing it to 23h41m56.447611141s I0918 22:55:06.366408 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0918 22:55:06.366429 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0918 22:55:06.366470 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0918 22:55:06.366526 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0918 22:55:06.366568 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0918 22:55:06.366589 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0918 22:55:06.366605 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0918 22:55:06.366627 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0918 22:55:06.366682 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" W0918 22:55:06.366708 1 shared_informer.go:593] resyncPeriod 14h12m17.19804366s is smaller than resyncCheckPeriod 23h41m56.447611141s and the informer has already started. Changing it to 23h41m56.447611141s I0918 22:55:06.366738 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0918 22:55:06.366802 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0918 22:55:06.366876 1 resource_quota_controller.go:294] "Starting resource quota controller" I0918 22:55:06.366940 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0918 22:55:06.366982 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0918 22:55:06.385205 1 shared_informer.go:318] Caches are synced for tokens I0918 22:55:06.386303 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0918 22:55:06.386438 1 namespace_controller.go:197] "Starting namespace controller" I0918 22:55:06.386466 1 shared_informer.go:311] Waiting for caches to sync for namespace I0918 22:55:06.397426 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0918 22:55:06.397632 1 daemon_controller.go:291] "Starting daemon sets controller" I0918 22:55:06.397648 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0918 22:55:06.414230 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0918 22:55:06.414300 1 tokencleaner.go:112] "Starting token cleaner controller" I0918 22:55:06.414434 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0918 22:55:06.414445 1 shared_informer.go:318] Caches are synced for token_cleaner E0918 22:55:06.423808 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0918 22:55:06.423833 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" E0918 22:55:06.437911 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0918 22:55:06.438068 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0918 22:55:06.452964 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0918 22:55:06.453292 1 pv_controller_base.go:319] "Starting persistent volume controller" I0918 22:55:06.453322 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0918 22:55:06.541417 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0918 22:55:06.541542 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0918 22:55:06.541609 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0918 22:55:06.696233 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0918 22:55:06.696374 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0918 22:55:06.696393 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0918 22:55:06.843314 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0918 22:55:06.843387 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0918 22:55:06.843501 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0918 22:55:06.843728 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0918 22:55:06.843769 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0918 22:55:06.843805 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0918 22:55:06.844390 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0918 22:55:06.844422 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0918 22:55:06.844508 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0918 22:55:06.844617 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0918 22:55:06.844698 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0918 22:55:06.844716 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0918 22:55:06.844755 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0918 22:55:06.888341 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0918 22:55:06.888514 1 cleaner.go:83] "Starting CSR cleaner controller" I0918 22:55:06.938702 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0918 22:55:06.938767 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0918 22:55:06.938801 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0918 22:55:06.938813 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0918 22:55:06.938884 1 node_lifecycle_controller.go:465] "Sending events to api server" I0918 22:55:06.938919 1 node_lifecycle_controller.go:476] "Starting node controller" I0918 22:55:06.938936 1 shared_informer.go:311] Waiting for caches to sync for taint I0918 22:55:07.097664 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0918 22:55:07.098075 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0918 22:55:07.098176 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0918 22:55:07.240930 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0918 22:55:07.241035 1 gc_controller.go:101] "Starting GC controller" I0918 22:55:07.241058 1 shared_informer.go:311] Waiting for caches to sync for GC I0918 22:55:07.392604 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0918 22:55:07.392717 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0918 22:55:07.392730 1 shared_informer.go:311] Waiting for caches to sync for deployment I0918 22:55:07.544972 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0918 22:55:07.545086 1 controller.go:169] "Starting ephemeral volume controller" I0918 22:55:07.545129 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0918 22:55:07.689021 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0918 22:55:07.689304 1 replica_set.go:214] "Starting controller" name="replicaset" I0918 22:55:07.689340 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0918 22:55:07.838896 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0918 22:55:07.839003 1 stateful_set.go:163] "Starting stateful set controller" I0918 22:55:07.839011 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0918 22:55:08.000939 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0918 22:55:08.001116 1 attach_detach_controller.go:337] "Starting attach detach controller" I0918 22:55:08.001162 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0918 22:55:08.139277 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0918 22:55:08.139344 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0918 22:55:08.139353 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0918 22:55:08.387965 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0918 22:55:08.388102 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0918 22:55:08.388113 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0918 22:55:08.388127 1 graph_builder.go:294] "Running" component="GraphBuilder" I0918 22:55:08.787760 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0918 22:55:08.787823 1 horizontal.go:200] "Starting HPA controller" I0918 22:55:08.787831 1 shared_informer.go:311] Waiting for caches to sync for HPA I0918 22:55:08.836903 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0918 22:55:08.836966 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0918 22:55:08.836979 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0918 22:55:08.990081 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0918 22:55:08.990183 1 publisher.go:102] "Starting root CA cert publisher controller" I0918 22:55:08.990194 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0918 22:55:09.141812 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0918 22:55:09.141865 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0918 22:55:09.289836 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0918 22:55:09.290055 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0918 22:55:09.290124 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0918 22:55:09.439506 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0918 22:55:09.439626 1 ttl_controller.go:124] "Starting TTL controller" I0918 22:55:09.439658 1 shared_informer.go:311] Waiting for caches to sync for TTL I0918 22:55:09.439677 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0918 22:55:09.590663 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0918 22:55:09.590808 1 endpoints_controller.go:177] "Starting endpoint controller" I0918 22:55:09.590834 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0918 22:55:09.740243 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0918 22:55:09.740384 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0918 22:55:09.740415 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0918 22:55:09.904892 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0918 22:55:09.904978 1 serviceaccounts_controller.go:111] "Starting service account controller" I0918 22:55:09.904988 1 shared_informer.go:311] Waiting for caches to sync for service account I0918 22:55:10.043967 1 controllermanager.go:642] "Started controller" controller="job-controller" I0918 22:55:10.044232 1 job_controller.go:226] "Starting job controller" I0918 22:55:10.044330 1 shared_informer.go:311] Waiting for caches to sync for job I0918 22:55:10.239250 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0918 22:55:10.239390 1 disruption.go:433] "Sending events to api server." I0918 22:55:10.239472 1 disruption.go:444] "Starting disruption controller" I0918 22:55:10.239488 1 shared_informer.go:311] Waiting for caches to sync for disruption I0918 22:55:10.391599 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0918 22:55:10.391888 1 pv_protection_controller.go:78] "Starting PV protection controller" I0918 22:55:10.391933 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0918 22:55:10.395774 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0918 22:55:10.404478 1 shared_informer.go:318] Caches are synced for TTL after finished I0918 22:55:10.413954 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" I0918 22:55:10.421371 1 shared_informer.go:318] Caches are synced for expand I0918 22:55:10.434920 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0918 22:55:10.437447 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0918 22:55:10.440164 1 shared_informer.go:318] Caches are synced for stateful set I0918 22:55:10.440291 1 shared_informer.go:318] Caches are synced for TTL I0918 22:55:10.440290 1 shared_informer.go:318] Caches are synced for taint I0918 22:55:10.440468 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0918 22:55:10.440505 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0918 22:55:10.440606 1 taint_manager.go:210] "Sending events to api server" I0918 22:55:10.440660 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0918 22:55:10.440748 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0918 22:55:10.441304 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" I0918 22:55:10.441471 1 shared_informer.go:318] Caches are synced for GC I0918 22:55:10.441501 1 shared_informer.go:318] Caches are synced for ReplicationController I0918 22:55:10.442334 1 shared_informer.go:318] Caches are synced for PVC protection I0918 22:55:10.442371 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0918 22:55:10.442379 1 shared_informer.go:318] Caches are synced for disruption I0918 22:55:10.444255 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0918 22:55:10.444484 1 shared_informer.go:318] Caches are synced for job I0918 22:55:10.444547 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0918 22:55:10.444642 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0918 22:55:10.444776 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0918 22:55:10.446050 1 shared_informer.go:318] Caches are synced for ephemeral I0918 22:55:10.489550 1 shared_informer.go:318] Caches are synced for ReplicaSet I0918 22:55:10.490403 1 shared_informer.go:318] Caches are synced for crt configmap I0918 22:55:10.490449 1 shared_informer.go:318] Caches are synced for cronjob I0918 22:55:10.490490 1 shared_informer.go:318] Caches are synced for HPA I0918 22:55:10.491639 1 shared_informer.go:318] Caches are synced for endpoint I0918 22:55:10.493065 1 shared_informer.go:318] Caches are synced for deployment I0918 22:55:10.497087 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0918 22:55:10.497831 1 shared_informer.go:318] Caches are synced for daemon sets I0918 22:55:10.500824 1 shared_informer.go:318] Caches are synced for endpoint_slice I0918 22:55:10.501212 1 shared_informer.go:318] Caches are synced for attach detach I0918 22:55:10.540227 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0918 22:55:10.553997 1 shared_informer.go:318] Caches are synced for persistent volume I0918 22:55:10.586977 1 shared_informer.go:318] Caches are synced for namespace I0918 22:55:10.592665 1 shared_informer.go:318] Caches are synced for PV protection I0918 22:55:10.605621 1 shared_informer.go:318] Caches are synced for service account I0918 22:55:10.667097 1 shared_informer.go:318] Caches are synced for resource quota I0918 22:55:10.696326 1 shared_informer.go:318] Caches are synced for resource quota I0918 22:55:10.739966 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" I0918 22:55:11.035932 1 shared_informer.go:318] Caches are synced for garbage collector I0918 22:55:11.088846 1 shared_informer.go:318] Caches are synced for garbage collector I0918 22:55:11.088941 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0918 22:55:12.085053 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" I0918 22:55:12.132400 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-6n58q" I0918 22:55:12.213500 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-bghfm" I0918 22:55:12.250967 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-6qxz9" I0918 22:55:12.281635 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="197.528257ms" I0918 22:55:12.307641 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="25.938303ms" I0918 22:55:12.308081 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="144.253µs" I0918 22:55:12.345854 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="117.413µs" I0918 22:55:38.025793 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" I0918 22:55:38.038937 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-cx5p5" I0918 22:55:38.049894 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="24.659225ms" I0918 22:55:38.050683 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" I0918 22:55:38.071543 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" I0918 22:55:38.073616 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-bghfm" I0918 22:55:38.084817 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="34.84106ms" I0918 22:55:38.085032 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="33.78818ms" I0918 22:55:38.095285 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-x5swj" I0918 22:55:38.098735 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="13.655667ms" I0918 22:55:38.098849 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="74.051µs" I0918 22:55:38.108640 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="23.766718ms" I0918 22:55:38.117324 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="8.641247ms" I0918 22:55:38.129128 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="11.747342ms" I0918 22:55:38.129265 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="101.822µs" I0918 22:55:58.267386 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" I0918 22:55:58.275183 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-g9kng" I0918 22:55:58.279535 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-thdl6" I0918 22:55:58.294460 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="28.356375ms" I0918 22:55:58.308087 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="13.573533ms" I0918 22:55:58.308165 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="52.551µs" I0918 22:56:08.335316 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:08.357410 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-ns22j" I0918 22:56:08.357816 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:08.366469 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:08.374688 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:09.828843 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="9.788514ms" I0918 22:56:09.829125 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="211.354µs" I0918 22:56:10.719115 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0918 22:56:10.719172 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" I0918 22:56:10.719197 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0918 22:56:10.719223 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0918 22:56:10.719250 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" I0918 22:56:10.719281 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0918 22:56:10.719312 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0918 22:56:10.719346 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0918 22:56:10.719384 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0918 22:56:10.719419 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0918 22:56:10.719518 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0918 22:56:10.719581 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" I0918 22:56:10.719746 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0918 22:56:10.719850 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0918 22:56:10.719935 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0918 22:56:10.720054 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0918 22:56:10.720099 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0918 22:56:10.720209 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0918 22:56:10.720301 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0918 22:56:10.720629 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0918 22:56:11.057660 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0918 22:56:12.021393 1 shared_informer.go:318] Caches are synced for resource quota I0918 22:56:12.258431 1 shared_informer.go:318] Caches are synced for garbage collector I0918 22:56:15.453340 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0918 22:56:18.671491 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:18.673025 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="108.422µs" I0918 22:56:18.690704 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:18.706628 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="249.903µs" I0918 22:56:20.871433 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="149.832µs" I0918 22:56:20.901072 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="9.791494ms" I0918 22:56:20.901273 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="96.832µs" I0918 22:56:24.886598 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:25.890381 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:25.895781 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:26.901935 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:27.648012 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:27.917661 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:27.941615 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:27.959198 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" I0918 22:56:27.959201 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:28.096082 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" I0918 22:56:28.109481 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-flwcv" I0918 22:56:28.126088 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="29.731594ms" I0918 22:56:28.168281 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="42.073089ms" I0918 22:56:28.168476 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="126.322µs" I0918 22:56:28.168552 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="52.281µs" I0918 22:56:29.931311 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="221.224µs" I0918 22:56:31.886638 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="152.062µs" I0918 22:56:31.891555 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="593.038µs" I0918 22:56:31.910885 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="196.203µs" I0918 22:56:31.929887 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="72.231µs" I0918 22:56:32.935573 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="168.932µs" I0918 22:56:32.973318 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="16.303392ms" I0918 22:56:32.974001 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="111.212µs" I0918 22:56:32.991327 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" I0918 22:56:32.998373 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="19.392151ms" I0918 22:56:32.998692 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="262.754µs" I0918 22:56:33.005676 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-6qxz9" I0918 22:56:33.024207 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="33.859339ms" I0918 22:56:33.033585 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="9.29762ms" I0918 22:56:33.033683 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="63.411µs" I0918 22:56:36.703278 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" I0918 22:56:36.718886 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-lsxr6" I0918 22:56:36.732190 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="29.951113ms" I0918 22:56:36.750523 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="18.224154ms" I0918 22:56:36.750767 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="160.972µs" I0918 22:56:36.754044 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="137.882µs" I0918 22:56:38.288409 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="78.831µs" I0918 22:56:38.763547 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="10.025917ms" I0918 22:56:38.763741 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="138.242µs" I0918 22:56:38.949106 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="82.041µs" I0918 22:56:38.953620 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="86.201µs" I0918 22:56:39.960160 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="8.445397ms" I0918 22:56:39.960243 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="45.551µs" I0918 22:56:42.028311 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0918 22:56:42.028377 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0918 22:56:42.028476 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0918 22:56:42.129496 1 shared_informer.go:318] Caches are synced for resource quota I0918 22:56:42.274239 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0918 22:56:42.374919 1 shared_informer.go:318] Caches are synced for garbage collector I0918 22:56:57.026005 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:56:57.066711 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0918 22:58:11.064840 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" I0918 22:58:11.709473 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."