I0824 15:37:21.140378 1 serving.go:348] Generated self-signed cert in-memory I0824 15:37:21.341918 1 controllermanager.go:189] "Starting" version="v1.28.13" I0824 15:37:21.341947 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0824 15:37:21.343558 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0824 15:37:21.343696 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0824 15:37:21.343997 1 secure_serving.go:213] Serving securely on [::]:10257 I0824 15:37:21.344074 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0824 15:37:21.344218 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... E0824 15:37:22.834538 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" I0824 15:37:25.765492 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0824 15:37:25.765816 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_94e673a3-a598-41c8-906f-fe81e9aa82e3 became leader" I0824 15:37:25.774988 1 shared_informer.go:311] Waiting for caches to sync for tokens I0824 15:37:25.813678 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0824 15:37:25.813816 1 namespace_controller.go:197] "Starting namespace controller" I0824 15:37:25.813859 1 shared_informer.go:311] Waiting for caches to sync for namespace I0824 15:37:25.825715 1 controllermanager.go:642] "Started controller" controller="job-controller" I0824 15:37:25.825857 1 job_controller.go:226] "Starting job controller" I0824 15:37:25.825894 1 shared_informer.go:311] Waiting for caches to sync for job I0824 15:37:25.836223 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0824 15:37:25.836393 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0824 15:37:25.836535 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0824 15:37:25.836540 1 replica_set.go:214] "Starting controller" name="replicaset" I0824 15:37:25.836742 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0824 15:37:25.852771 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0824 15:37:25.853022 1 attach_detach_controller.go:337] "Starting attach detach controller" I0824 15:37:25.853044 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0824 15:37:25.874426 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0824 15:37:25.874869 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0824 15:37:25.874985 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0824 15:37:25.875588 1 shared_informer.go:318] Caches are synced for tokens I0824 15:37:25.884537 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0824 15:37:25.884750 1 disruption.go:433] "Sending events to api server." I0824 15:37:25.884840 1 disruption.go:444] "Starting disruption controller" I0824 15:37:25.884854 1 shared_informer.go:311] Waiting for caches to sync for disruption I0824 15:37:25.896662 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0824 15:37:25.896775 1 ttl_controller.go:124] "Starting TTL controller" I0824 15:37:25.896946 1 shared_informer.go:311] Waiting for caches to sync for TTL I0824 15:37:25.908967 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0824 15:37:25.909175 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0824 15:37:25.926528 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0824 15:37:25.926554 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0824 15:37:25.926591 1 graph_builder.go:294] "Running" component="GraphBuilder" I0824 15:37:25.926714 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0824 15:37:26.173222 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0824 15:37:26.173332 1 cleaner.go:83] "Starting CSR cleaner controller" I0824 15:37:26.325962 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0824 15:37:26.326020 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0824 15:37:26.326160 1 node_lifecycle_controller.go:465] "Sending events to api server" I0824 15:37:26.326197 1 node_lifecycle_controller.go:476] "Starting node controller" I0824 15:37:26.326208 1 shared_informer.go:311] Waiting for caches to sync for taint I0824 15:37:26.471328 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0824 15:37:26.471449 1 pv_controller_base.go:319] "Starting persistent volume controller" I0824 15:37:26.471459 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0824 15:37:26.622970 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0824 15:37:26.623054 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0824 15:37:26.623065 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0824 15:37:26.670951 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0824 15:37:26.670992 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0824 15:37:26.671027 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0824 15:37:26.671752 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0824 15:37:26.671816 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0824 15:37:26.671813 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0824 15:37:26.672423 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0824 15:37:26.672448 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0824 15:37:26.672481 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0824 15:37:26.672958 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0824 15:37:26.673053 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0824 15:37:26.673073 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0824 15:37:26.673109 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0824 15:37:26.824978 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0824 15:37:26.825221 1 endpoints_controller.go:177] "Starting endpoint controller" I0824 15:37:26.825256 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0824 15:37:26.970978 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0824 15:37:26.971186 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0824 15:37:26.971225 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0824 15:37:27.121462 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0824 15:37:27.121525 1 gc_controller.go:101] "Starting GC controller" I0824 15:37:27.121664 1 shared_informer.go:311] Waiting for caches to sync for GC I0824 15:37:27.272591 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0824 15:37:27.272765 1 daemon_controller.go:291] "Starting daemon sets controller" I0824 15:37:27.272783 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0824 15:37:27.424604 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0824 15:37:27.424972 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0824 15:37:27.425018 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0824 15:37:27.727051 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0824 15:37:27.727116 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0824 15:37:27.727153 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0824 15:37:27.727204 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0824 15:37:27.727226 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0824 15:37:27.727284 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0824 15:37:27.727469 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0824 15:37:27.727527 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0824 15:37:27.727552 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0824 15:37:27.727586 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0824 15:37:27.727694 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0824 15:37:27.727733 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0824 15:37:27.727751 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0824 15:37:27.727777 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0824 15:37:27.727873 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0824 15:37:27.727896 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0824 15:37:27.727977 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0824 15:37:27.728013 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0824 15:37:27.728138 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0824 15:37:27.728194 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0824 15:37:27.728345 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0824 15:37:27.728363 1 resource_quota_controller.go:294] "Starting resource quota controller" I0824 15:37:27.728380 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0824 15:37:27.728406 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0824 15:37:27.874795 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0824 15:37:27.875000 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0824 15:37:27.875019 1 shared_informer.go:311] Waiting for caches to sync for deployment E0824 15:37:27.920608 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0824 15:37:27.920643 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0824 15:37:28.073620 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0824 15:37:28.073693 1 expand_controller.go:328] "Starting expand controller" I0824 15:37:28.073722 1 shared_informer.go:311] Waiting for caches to sync for expand I0824 15:37:28.221356 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0824 15:37:28.221452 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0824 15:37:28.221467 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0824 15:37:28.372067 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0824 15:37:28.372192 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0824 15:37:28.372213 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0824 15:37:28.535015 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0824 15:37:28.535090 1 serviceaccounts_controller.go:111] "Starting service account controller" I0824 15:37:28.535125 1 shared_informer.go:311] Waiting for caches to sync for service account I0824 15:37:28.678187 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0824 15:37:28.678276 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0824 15:37:28.678437 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0824 15:37:28.824904 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0824 15:37:28.824992 1 pv_protection_controller.go:78] "Starting PV protection controller" I0824 15:37:28.825004 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0824 15:37:28.975313 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0824 15:37:28.975373 1 controller.go:169] "Starting ephemeral volume controller" I0824 15:37:28.975452 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0824 15:37:29.271253 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0824 15:37:29.271338 1 horizontal.go:200] "Starting HPA controller" I0824 15:37:29.271384 1 shared_informer.go:311] Waiting for caches to sync for HPA I0824 15:37:29.427952 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0824 15:37:29.428357 1 stateful_set.go:163] "Starting stateful set controller" I0824 15:37:29.428394 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0824 15:37:29.572013 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0824 15:37:29.572055 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0824 15:37:29.572100 1 tokencleaner.go:112] "Starting token cleaner controller" I0824 15:37:29.572110 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0824 15:37:29.572119 1 shared_informer.go:318] Caches are synced for token_cleaner E0824 15:37:29.725745 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0824 15:37:29.725791 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0824 15:37:29.772640 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0824 15:37:29.772860 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0824 15:37:29.772913 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0824 15:37:29.922007 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0824 15:37:29.922194 1 publisher.go:102] "Starting root CA cert publisher controller" I0824 15:37:29.922239 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0824 15:37:29.927755 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0824 15:37:29.934010 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" I0824 15:37:29.935302 1 shared_informer.go:318] Caches are synced for service account I0824 15:37:29.937004 1 shared_informer.go:318] Caches are synced for ReplicaSet I0824 15:37:29.940519 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0824 15:37:29.953391 1 shared_informer.go:318] Caches are synced for attach detach I0824 15:37:29.971398 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0824 15:37:29.971450 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0824 15:37:29.971575 1 shared_informer.go:318] Caches are synced for persistent volume I0824 15:37:29.971610 1 shared_informer.go:318] Caches are synced for HPA I0824 15:37:29.972904 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0824 15:37:29.973010 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0824 15:37:29.973133 1 shared_informer.go:318] Caches are synced for ReplicationController I0824 15:37:29.973194 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0824 15:37:29.973198 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0824 15:37:29.974746 1 shared_informer.go:318] Caches are synced for expand I0824 15:37:29.976095 1 shared_informer.go:318] Caches are synced for endpoint_slice I0824 15:37:29.976102 1 shared_informer.go:318] Caches are synced for ephemeral I0824 15:37:29.976229 1 shared_informer.go:318] Caches are synced for deployment I0824 15:37:29.978710 1 shared_informer.go:318] Caches are synced for PVC protection I0824 15:37:29.985359 1 shared_informer.go:318] Caches are synced for disruption I0824 15:37:29.997663 1 shared_informer.go:318] Caches are synced for TTL I0824 15:37:30.011021 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0824 15:37:30.014259 1 shared_informer.go:318] Caches are synced for namespace I0824 15:37:30.021988 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0824 15:37:30.022072 1 shared_informer.go:318] Caches are synced for GC I0824 15:37:30.022649 1 shared_informer.go:318] Caches are synced for crt configmap I0824 15:37:30.023117 1 shared_informer.go:318] Caches are synced for TTL after finished I0824 15:37:30.025133 1 shared_informer.go:318] Caches are synced for cronjob I0824 15:37:30.025213 1 shared_informer.go:318] Caches are synced for PV protection I0824 15:37:30.025298 1 shared_informer.go:318] Caches are synced for endpoint I0824 15:37:30.026029 1 shared_informer.go:318] Caches are synced for job I0824 15:37:30.026264 1 shared_informer.go:318] Caches are synced for taint I0824 15:37:30.026450 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0824 15:37:30.026503 1 taint_manager.go:210] "Sending events to api server" I0824 15:37:30.026812 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0824 15:37:30.026984 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" I0824 15:37:30.027158 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0824 15:37:30.027295 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0824 15:37:30.129063 1 shared_informer.go:318] Caches are synced for stateful set I0824 15:37:30.129077 1 shared_informer.go:318] Caches are synced for resource quota I0824 15:37:30.173559 1 shared_informer.go:318] Caches are synced for daemon sets I0824 15:37:30.228517 1 shared_informer.go:318] Caches are synced for resource quota I0824 15:37:30.541431 1 shared_informer.go:318] Caches are synced for garbage collector I0824 15:37:30.627606 1 shared_informer.go:318] Caches are synced for garbage collector I0824 15:37:30.627650 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0824 15:37:30.632958 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" I0824 15:37:31.089901 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-q24tj" I0824 15:37:31.147682 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-gkrxb" I0824 15:37:31.157242 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-gmg7q" I0824 15:37:31.168098 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="535.725927ms" I0824 15:37:31.180218 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="11.96717ms" I0824 15:37:31.180392 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="115.833µs"