I0919 01:00:10.436633 1 serving.go:348] Generated self-signed cert in-memory I0919 01:00:11.032758 1 controllermanager.go:189] "Starting" version="v1.28.13" I0919 01:00:11.032792 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0919 01:00:11.034427 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0919 01:00:11.034604 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0919 01:00:11.034686 1 secure_serving.go:213] Serving securely on [::]:10257 I0919 01:00:11.034771 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0919 01:00:11.034900 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... E0919 01:00:11.955976 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" I0919 01:00:15.913239 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0919 01:00:15.913448 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_ec2d7fd5-4db2-4f87-8a1d-ae362bb0aee9 became leader" I0919 01:00:15.923704 1 shared_informer.go:311] Waiting for caches to sync for tokens I0919 01:00:15.929829 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0919 01:00:15.932142 1 stateful_set.go:163] "Starting stateful set controller" I0919 01:00:15.932164 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0919 01:00:15.940391 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0919 01:00:15.940518 1 expand_controller.go:328] "Starting expand controller" I0919 01:00:15.940553 1 shared_informer.go:311] Waiting for caches to sync for expand I0919 01:00:15.952201 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0919 01:00:15.952280 1 pv_protection_controller.go:78] "Starting PV protection controller" I0919 01:00:15.952302 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0919 01:00:15.958532 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0919 01:00:15.958681 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0919 01:00:15.958695 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0919 01:00:15.976975 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0919 01:00:15.977002 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0919 01:00:15.977044 1 horizontal.go:200] "Starting HPA controller" I0919 01:00:15.977066 1 shared_informer.go:311] Waiting for caches to sync for HPA I0919 01:00:16.008286 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0919 01:00:16.008328 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0919 01:00:16.008358 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0919 01:00:16.008396 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0919 01:00:16.008484 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0919 01:00:16.008529 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0919 01:00:16.008569 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0919 01:00:16.008614 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0919 01:00:16.008647 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0919 01:00:16.008670 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0919 01:00:16.008701 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0919 01:00:16.008732 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0919 01:00:16.008774 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0919 01:00:16.008865 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0919 01:00:16.008892 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0919 01:00:16.008923 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0919 01:00:16.009007 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0919 01:00:16.009033 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0919 01:00:16.009058 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0919 01:00:16.009100 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0919 01:00:16.009135 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0919 01:00:16.009176 1 resource_quota_controller.go:294] "Starting resource quota controller" I0919 01:00:16.009198 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0919 01:00:16.009223 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0919 01:00:16.021028 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0919 01:00:16.021122 1 cleaner.go:83] "Starting CSR cleaner controller" I0919 01:00:16.023839 1 shared_informer.go:318] Caches are synced for tokens I0919 01:00:16.027265 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0919 01:00:16.027442 1 daemon_controller.go:291] "Starting daemon sets controller" I0919 01:00:16.027457 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0919 01:00:16.166868 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0919 01:00:16.167018 1 disruption.go:433] "Sending events to api server." I0919 01:00:16.167082 1 disruption.go:444] "Starting disruption controller" I0919 01:00:16.167101 1 shared_informer.go:311] Waiting for caches to sync for disruption I0919 01:00:16.320834 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0919 01:00:16.320916 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0919 01:00:16.320934 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0919 01:00:16.468205 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0919 01:00:16.468234 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0919 01:00:16.468247 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0919 01:00:16.620148 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0919 01:00:16.620272 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0919 01:00:16.620422 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0919 01:00:16.769137 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0919 01:00:16.769197 1 serviceaccounts_controller.go:111] "Starting service account controller" I0919 01:00:16.769233 1 shared_informer.go:311] Waiting for caches to sync for service account I0919 01:00:16.935079 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0919 01:00:16.935266 1 tokencleaner.go:112] "Starting token cleaner controller" I0919 01:00:16.935284 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0919 01:00:16.935295 1 shared_informer.go:318] Caches are synced for token_cleaner I0919 01:00:17.160916 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0919 01:00:17.161115 1 publisher.go:102] "Starting root CA cert publisher controller" I0919 01:00:17.161139 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0919 01:00:17.220315 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0919 01:00:17.220393 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0919 01:00:17.220401 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0919 01:00:17.273792 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0919 01:00:17.273863 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0919 01:00:17.273874 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0919 01:00:17.420798 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0919 01:00:17.420949 1 attach_detach_controller.go:337] "Starting attach detach controller" I0919 01:00:17.420991 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0919 01:00:17.573057 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0919 01:00:17.573172 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0919 01:00:17.573189 1 shared_informer.go:311] Waiting for caches to sync for deployment I0919 01:00:17.718856 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0919 01:00:17.719011 1 replica_set.go:214] "Starting controller" name="replicaset" I0919 01:00:17.719050 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet E0919 01:00:17.868076 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0919 01:00:17.868107 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0919 01:00:18.019257 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0919 01:00:18.019394 1 controller.go:169] "Starting ephemeral volume controller" I0919 01:00:18.019419 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0919 01:00:18.170360 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0919 01:00:18.170756 1 endpoints_controller.go:177] "Starting endpoint controller" I0919 01:00:18.170825 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0919 01:00:18.417410 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0919 01:00:18.417448 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0919 01:00:18.417505 1 graph_builder.go:294] "Running" component="GraphBuilder" I0919 01:00:18.417528 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0919 01:00:18.517770 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0919 01:00:18.517839 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0919 01:00:18.517875 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0919 01:00:18.517888 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0919 01:00:18.518079 1 node_lifecycle_controller.go:465] "Sending events to api server" I0919 01:00:18.518182 1 node_lifecycle_controller.go:476] "Starting node controller" I0919 01:00:18.518208 1 shared_informer.go:311] Waiting for caches to sync for taint I0919 01:00:18.726619 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0919 01:00:18.726705 1 pv_controller_base.go:319] "Starting persistent volume controller" I0919 01:00:18.726714 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0919 01:00:18.872647 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0919 01:00:18.872770 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0919 01:00:18.872784 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0919 01:00:19.020719 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0919 01:00:19.020854 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0919 01:00:19.020876 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0919 01:00:19.170792 1 controllermanager.go:642] "Started controller" controller="job-controller" I0919 01:00:19.171049 1 job_controller.go:226] "Starting job controller" I0919 01:00:19.171097 1 shared_informer.go:311] Waiting for caches to sync for job I0919 01:00:19.218725 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0919 01:00:19.218839 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0919 01:00:19.218918 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0919 01:00:19.219046 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0919 01:00:19.219069 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0919 01:00:19.219098 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0919 01:00:19.219548 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0919 01:00:19.219591 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0919 01:00:19.219593 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0919 01:00:19.219776 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0919 01:00:19.219858 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0919 01:00:19.219872 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0919 01:00:19.219925 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0919 01:00:19.370594 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0919 01:00:19.370658 1 ttl_controller.go:124] "Starting TTL controller" I0919 01:00:19.370665 1 shared_informer.go:311] Waiting for caches to sync for TTL I0919 01:00:19.522301 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0919 01:00:19.522381 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer E0919 01:00:19.684437 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0919 01:00:19.684466 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0919 01:00:19.820895 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0919 01:00:19.821004 1 gc_controller.go:101] "Starting GC controller" I0919 01:00:19.821132 1 shared_informer.go:311] Waiting for caches to sync for GC I0919 01:00:20.077975 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0919 01:00:20.078016 1 namespace_controller.go:197] "Starting namespace controller" I0919 01:00:20.078080 1 shared_informer.go:311] Waiting for caches to sync for namespace I0919 01:00:20.080313 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0919 01:00:20.084325 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" I0919 01:00:20.093365 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0919 01:00:20.119229 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0919 01:00:20.119360 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0919 01:00:20.120528 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0919 01:00:20.120602 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0919 01:00:20.120697 1 shared_informer.go:318] Caches are synced for cronjob I0919 01:00:20.121774 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0919 01:00:20.141220 1 shared_informer.go:318] Caches are synced for expand I0919 01:00:20.152691 1 shared_informer.go:318] Caches are synced for PV protection I0919 01:00:20.158868 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0919 01:00:20.170029 1 shared_informer.go:318] Caches are synced for service account I0919 01:00:20.171566 1 shared_informer.go:318] Caches are synced for TTL I0919 01:00:20.173536 1 shared_informer.go:318] Caches are synced for TTL after finished I0919 01:00:20.173985 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0919 01:00:20.178317 1 shared_informer.go:318] Caches are synced for namespace I0919 01:00:20.232625 1 shared_informer.go:318] Caches are synced for stateful set I0919 01:00:20.267453 1 shared_informer.go:318] Caches are synced for disruption I0919 01:00:20.268693 1 shared_informer.go:318] Caches are synced for PVC protection I0919 01:00:20.271878 1 shared_informer.go:318] Caches are synced for job I0919 01:00:20.271939 1 shared_informer.go:318] Caches are synced for endpoint I0919 01:00:20.273246 1 shared_informer.go:318] Caches are synced for deployment I0919 01:00:20.278158 1 shared_informer.go:318] Caches are synced for HPA I0919 01:00:20.310272 1 shared_informer.go:318] Caches are synced for resource quota I0919 01:00:20.318884 1 shared_informer.go:318] Caches are synced for taint I0919 01:00:20.319005 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0919 01:00:20.319061 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0919 01:00:20.319119 1 taint_manager.go:210] "Sending events to api server" I0919 01:00:20.319154 1 shared_informer.go:318] Caches are synced for ReplicaSet I0919 01:00:20.319155 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0919 01:00:20.319196 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" I0919 01:00:20.319234 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0919 01:00:20.320392 1 shared_informer.go:318] Caches are synced for ephemeral I0919 01:00:20.320578 1 shared_informer.go:318] Caches are synced for endpoint_slice I0919 01:00:20.320933 1 shared_informer.go:318] Caches are synced for ReplicationController I0919 01:00:20.321069 1 shared_informer.go:318] Caches are synced for attach detach I0919 01:00:20.321821 1 shared_informer.go:318] Caches are synced for GC I0919 01:00:20.323149 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0919 01:00:20.327419 1 shared_informer.go:318] Caches are synced for persistent volume I0919 01:00:20.327500 1 shared_informer.go:318] Caches are synced for daemon sets I0919 01:00:20.362116 1 shared_informer.go:318] Caches are synced for crt configmap I0919 01:00:20.380876 1 shared_informer.go:318] Caches are synced for resource quota I0919 01:00:20.694332 1 shared_informer.go:318] Caches are synced for garbage collector I0919 01:00:20.718536 1 shared_informer.go:318] Caches are synced for garbage collector I0919 01:00:20.718644 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0919 01:00:20.934029 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" I0919 01:00:21.139425 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-npj9m" I0919 01:00:21.282087 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-pdxgs" I0919 01:00:21.295918 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-pkf4r" I0919 01:00:21.307530 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="374.295164ms" I0919 01:00:21.321058 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="13.463295ms" I0919 01:00:21.321433 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="326.297µs" I0919 01:00:21.325646 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="77.942µs" I0919 01:00:34.240839 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" I0919 01:00:34.252860 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-ck75p" I0919 01:00:34.264978 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="24.43196ms" I0919 01:00:34.272997 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" I0919 01:00:34.276693 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="11.661195ms" I0919 01:00:34.276779 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="52.821µs" I0919 01:00:34.289091 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-pdxgs" I0919 01:00:34.293621 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" I0919 01:00:34.302326 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="29.770733ms" I0919 01:00:34.305744 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-sftzf" I0919 01:00:34.310678 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="8.266575ms" I0919 01:00:34.310991 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="263.475µs" I0919 01:00:34.313702 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="19.812499ms" I0919 01:00:34.322552 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="8.804395ms" I0919 01:00:34.348976 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="26.377854ms" I0919 01:00:34.349240 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="205.864µs" I0919 01:00:48.340159 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" I0919 01:00:48.348895 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-xw8wk" I0919 01:00:48.356439 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-456zl" I0919 01:00:48.372103 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="33.071571ms" I0919 01:00:48.403039 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="30.704342ms" I0919 01:00:48.442528 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="39.425706ms" I0919 01:00:48.442784 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="146.412µs" I0919 01:00:50.388027 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xlistenersets.gateway.networking.x-k8s.io" I0919 01:00:50.388067 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="referencegrants.gateway.networking.k8s.io" I0919 01:00:50.388088 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="udproutes.gateway.networking.k8s.io" I0919 01:00:50.388133 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0919 01:00:50.388202 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtlspolicies.gateway.networking.k8s.io" I0919 01:00:50.388327 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tcproutes.gateway.networking.k8s.io" I0919 01:00:50.388381 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0919 01:00:50.688749 1 shared_informer.go:318] Caches are synced for resource quota I0919 01:00:50.707720 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0919 01:00:51.008493 1 shared_informer.go:318] Caches are synced for garbage collector I0919 01:00:51.015335 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="87.412µs" I0919 01:00:51.074441 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="22.066396ms" I0919 01:00:51.074731 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-869df985b8" duration="123.922µs" I0919 01:00:57.157033 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:00:57.175489 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:00:57.175796 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-fxs5d" I0919 01:00:57.185998 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:00:57.187724 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:10.257373 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="61.181µs" I0919 01:01:10.257768 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:10.283621 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="78.94µs" I0919 01:01:10.299912 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:10.326899 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0919 01:01:12.114748 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="307.254µs" I0919 01:01:12.153853 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="15.933785ms" I0919 01:01:12.154012 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="117.022µs" I0919 01:01:16.133437 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:17.142917 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:18.137744 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:18.153338 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:20.147917 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:20.696392 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutefilters.gateway.envoyproxy.io" I0919 01:01:20.696742 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0919 01:01:20.696968 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0919 01:01:20.697186 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0919 01:01:20.697396 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="backends.gateway.envoyproxy.io" I0919 01:01:20.697571 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoypatchpolicies.gateway.envoyproxy.io" W0919 01:01:20.697690 1 shared_informer.go:593] resyncPeriod 17h18m34.151847239s is smaller than resyncCheckPeriod 17h46m17.263833431s and the informer has already started. Changing it to 17h46m17.263833431s I0919 01:01:20.697876 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="grpcroutes.gateway.networking.k8s.io" I0919 01:01:20.698039 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0919 01:01:20.698199 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0919 01:01:20.698359 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="securitypolicies.gateway.envoyproxy.io" I0919 01:01:20.698617 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyproxies.gateway.envoyproxy.io" W0919 01:01:20.698748 1 shared_informer.go:593] resyncPeriod 17h26m33.805185368s is smaller than resyncCheckPeriod 17h46m17.263833431s and the informer has already started. Changing it to 17h46m17.263833431s I0919 01:01:20.698985 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="gateways.gateway.networking.k8s.io" I0919 01:01:20.699173 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="httproutes.gateway.networking.k8s.io" W0919 01:01:20.699327 1 shared_informer.go:593] resyncPeriod 12h40m37.187225871s is smaller than resyncCheckPeriod 17h46m17.263833431s and the informer has already started. Changing it to 17h46m17.263833431s I0919 01:01:20.699475 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="tlsroutes.gateway.networking.k8s.io" I0919 01:01:20.699710 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0919 01:01:20.700096 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0919 01:01:21.022143 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0919 01:01:21.172735 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:21.187709 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:21.198485 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:21.199011 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" I0919 01:01:21.268346 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" I0919 01:01:21.276940 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-xh4tp" I0919 01:01:21.292601 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="24.606692ms" I0919 01:01:21.306647 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="13.987851ms" I0919 01:01:21.306929 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="204.633µs" I0919 01:01:21.307073 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="41.981µs" I0919 01:01:21.600548 1 shared_informer.go:318] Caches are synced for resource quota I0919 01:01:21.623270 1 shared_informer.go:318] Caches are synced for garbage collector I0919 01:01:22.167464 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="106.402µs" I0919 01:01:24.382727 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="67.291µs" I0919 01:01:24.387202 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="128.732µs" I0919 01:01:24.413772 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="99.052µs" I0919 01:01:24.427410 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="65.261µs" I0919 01:01:25.181694 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="83.022µs" I0919 01:01:26.178216 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="272.404µs" I0919 01:01:26.206504 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="15.565281ms" I0919 01:01:26.206652 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="91.721µs" I0919 01:01:26.215892 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" I0919 01:01:26.229370 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-pkf4r" I0919 01:01:26.240016 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="18.717445ms" I0919 01:01:26.240186 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-67659f764b" duration="104.461µs" I0919 01:01:26.246743 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="31.425113ms" I0919 01:01:26.271219 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="24.394706ms" I0919 01:01:26.271377 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="95.281µs" I0919 01:01:28.637763 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" I0919 01:01:28.661062 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-fvfwx" I0919 01:01:28.676935 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="39.372363ms" I0919 01:01:28.698787 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="21.760857ms" I0919 01:01:28.698855 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="35.72µs" I0919 01:01:31.697203 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="27.30107ms" I0919 01:01:31.699313 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-78446f96c9" duration="61.631µs" I0919 01:01:31.700411 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="68.251µs" I0919 01:01:32.281874 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="66.552025ms" I0919 01:01:32.282387 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-679c578f5" duration="177.282µs" I0919 01:01:32.288322 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="130.292µs" I0919 01:01:32.312363 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="95.621µs" I0919 01:01:51.028262 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:01:51.093412 1 job_controller.go:562] "enqueueing job" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" I0919 01:03:00.709485 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" I0919 01:03:01.353574 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." I0919 01:03:05.334671 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."