I0826 00:16:00.726053 1 serving.go:348] Generated self-signed cert in-memory I0826 00:16:01.219196 1 controllermanager.go:189] "Starting" version="v1.28.13" I0826 00:16:01.219221 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0826 00:16:01.220491 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0826 00:16:01.220537 1 secure_serving.go:213] Serving securely on [::]:10257 I0826 00:16:01.220561 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0826 00:16:01.220713 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0826 00:16:01.220857 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" E0826 00:16:02.924491 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" I0826 00:16:05.336971 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0826 00:16:05.337241 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_02ee178e-c93a-42c6-b8c1-b1d84bff9e5a became leader" I0826 00:16:05.345558 1 shared_informer.go:311] Waiting for caches to sync for tokens I0826 00:16:05.353472 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0826 00:16:05.353546 1 gc_controller.go:101] "Starting GC controller" I0826 00:16:05.353562 1 shared_informer.go:311] Waiting for caches to sync for GC I0826 00:16:05.360587 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0826 00:16:05.360711 1 tokencleaner.go:112] "Starting token cleaner controller" I0826 00:16:05.360727 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0826 00:16:05.360735 1 shared_informer.go:318] Caches are synced for token_cleaner E0826 00:16:05.366952 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0826 00:16:05.366980 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0826 00:16:05.373414 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0826 00:16:05.373610 1 attach_detach_controller.go:337] "Starting attach detach controller" I0826 00:16:05.373625 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0826 00:16:05.379137 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0826 00:16:05.379326 1 expand_controller.go:328] "Starting expand controller" I0826 00:16:05.379341 1 shared_informer.go:311] Waiting for caches to sync for expand I0826 00:16:05.388350 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0826 00:16:05.388389 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0826 00:16:05.388399 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0826 00:16:05.388541 1 stateful_set.go:163] "Starting stateful set controller" I0826 00:16:05.388555 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0826 00:16:05.394949 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0826 00:16:05.394993 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0826 00:16:05.395007 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0826 00:16:05.401732 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0826 00:16:05.401938 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0826 00:16:05.401984 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0826 00:16:05.411405 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0826 00:16:05.411618 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0826 00:16:05.411650 1 shared_informer.go:311] Waiting for caches to sync for cronjob E0826 00:16:05.418985 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0826 00:16:05.419015 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" I0826 00:16:05.446466 1 shared_informer.go:318] Caches are synced for tokens I0826 00:16:05.542093 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0826 00:16:05.542207 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0826 00:16:05.542285 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0826 00:16:05.692367 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0826 00:16:05.692428 1 publisher.go:102] "Starting root CA cert publisher controller" I0826 00:16:05.692448 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0826 00:16:05.843542 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0826 00:16:05.843762 1 pv_controller_base.go:319] "Starting persistent volume controller" I0826 00:16:05.843813 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0826 00:16:05.994759 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0826 00:16:05.994865 1 endpoints_controller.go:177] "Starting endpoint controller" I0826 00:16:05.994892 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0826 00:16:06.151410 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0826 00:16:06.151582 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0826 00:16:06.151614 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0826 00:16:06.292808 1 controllermanager.go:642] "Started controller" controller="job-controller" I0826 00:16:06.292880 1 job_controller.go:226] "Starting job controller" I0826 00:16:06.292889 1 shared_informer.go:311] Waiting for caches to sync for job I0826 00:16:06.490542 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0826 00:16:06.490604 1 disruption.go:433] "Sending events to api server." I0826 00:16:06.490828 1 disruption.go:444] "Starting disruption controller" I0826 00:16:06.490891 1 shared_informer.go:311] Waiting for caches to sync for disruption I0826 00:16:06.643850 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0826 00:16:06.643915 1 cleaner.go:83] "Starting CSR cleaner controller" I0826 00:16:06.793053 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0826 00:16:06.793210 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0826 00:16:06.793245 1 shared_informer.go:311] Waiting for caches to sync for deployment I0826 00:16:07.091753 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0826 00:16:07.091796 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0826 00:16:07.091838 1 horizontal.go:200] "Starting HPA controller" I0826 00:16:07.091889 1 shared_informer.go:311] Waiting for caches to sync for HPA I0826 00:16:07.248240 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0826 00:16:07.248293 1 controller.go:169] "Starting ephemeral volume controller" I0826 00:16:07.248314 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0826 00:16:07.494895 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0826 00:16:07.494962 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0826 00:16:07.495006 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0826 00:16:07.495051 1 graph_builder.go:294] "Running" component="GraphBuilder" I0826 00:16:07.541658 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0826 00:16:07.541699 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0826 00:16:07.541749 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0826 00:16:07.542144 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0826 00:16:07.542196 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0826 00:16:07.542236 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0826 00:16:07.542638 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0826 00:16:07.542674 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0826 00:16:07.542771 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0826 00:16:07.542861 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0826 00:16:07.542939 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0826 00:16:07.542956 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0826 00:16:07.542981 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0826 00:16:07.642541 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0826 00:16:07.642714 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0826 00:16:07.642856 1 node_lifecycle_controller.go:465] "Sending events to api server" I0826 00:16:07.642934 1 node_lifecycle_controller.go:476] "Starting node controller" I0826 00:16:07.642946 1 shared_informer.go:311] Waiting for caches to sync for taint I0826 00:16:07.844064 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0826 00:16:07.844155 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0826 00:16:07.844201 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0826 00:16:07.995275 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0826 00:16:07.995347 1 pv_protection_controller.go:78] "Starting PV protection controller" I0826 00:16:07.995374 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0826 00:16:08.146757 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0826 00:16:08.146965 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0826 00:16:08.146982 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0826 00:16:08.294670 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0826 00:16:08.294736 1 ttl_controller.go:124] "Starting TTL controller" I0826 00:16:08.294763 1 shared_informer.go:311] Waiting for caches to sync for TTL I0826 00:16:08.341096 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0826 00:16:08.341159 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0826 00:16:08.341171 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0826 00:16:08.495548 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0826 00:16:08.495615 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0826 00:16:08.800178 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0826 00:16:08.800295 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0826 00:16:08.800366 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0826 00:16:08.800449 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0826 00:16:08.800487 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" I0826 00:16:08.800549 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0826 00:16:08.800617 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0826 00:16:08.800781 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0826 00:16:08.800822 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0826 00:16:08.800886 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0826 00:16:08.800918 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0826 00:16:08.800994 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0826 00:16:08.801208 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0826 00:16:08.801302 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0826 00:16:08.801416 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0826 00:16:08.801448 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0826 00:16:08.801858 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0826 00:16:08.801955 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0826 00:16:08.801990 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0826 00:16:08.802051 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0826 00:16:08.802120 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0826 00:16:08.802195 1 resource_quota_controller.go:294] "Starting resource quota controller" I0826 00:16:08.802248 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0826 00:16:08.802276 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0826 00:16:09.050018 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0826 00:16:09.050091 1 namespace_controller.go:197] "Starting namespace controller" I0826 00:16:09.050106 1 shared_informer.go:311] Waiting for caches to sync for namespace I0826 00:16:09.197813 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0826 00:16:09.197921 1 serviceaccounts_controller.go:111] "Starting service account controller" I0826 00:16:09.197972 1 shared_informer.go:311] Waiting for caches to sync for service account I0826 00:16:09.342476 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0826 00:16:09.342624 1 daemon_controller.go:291] "Starting daemon sets controller" I0826 00:16:09.342662 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0826 00:16:09.492934 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0826 00:16:09.493467 1 replica_set.go:214] "Starting controller" name="replicaset" I0826 00:16:09.493489 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet I0826 00:16:09.499115 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0826 00:16:09.505992 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" I0826 00:16:09.511956 1 shared_informer.go:318] Caches are synced for cronjob I0826 00:16:09.516933 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0826 00:16:09.542268 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0826 00:16:09.542464 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0826 00:16:09.542724 1 shared_informer.go:318] Caches are synced for daemon sets I0826 00:16:09.542725 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0826 00:16:09.542659 1 shared_informer.go:318] Caches are synced for PVC protection I0826 00:16:09.542531 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0826 00:16:09.544194 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0826 00:16:09.544199 1 shared_informer.go:318] Caches are synced for persistent volume I0826 00:16:09.544285 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0826 00:16:09.544624 1 shared_informer.go:318] Caches are synced for taint I0826 00:16:09.544822 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0826 00:16:09.544879 1 taint_manager.go:210] "Sending events to api server" I0826 00:16:09.545016 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0826 00:16:09.545080 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" I0826 00:16:09.545410 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0826 00:16:09.545688 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0826 00:16:09.547675 1 shared_informer.go:318] Caches are synced for ReplicationController I0826 00:16:09.548610 1 shared_informer.go:318] Caches are synced for ephemeral I0826 00:16:09.551133 1 shared_informer.go:318] Caches are synced for namespace I0826 00:16:09.552449 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0826 00:16:09.553796 1 shared_informer.go:318] Caches are synced for GC I0826 00:16:09.574091 1 shared_informer.go:318] Caches are synced for attach detach I0826 00:16:09.580386 1 shared_informer.go:318] Caches are synced for expand I0826 00:16:09.588861 1 shared_informer.go:318] Caches are synced for stateful set I0826 00:16:09.592574 1 shared_informer.go:318] Caches are synced for HPA I0826 00:16:09.592653 1 shared_informer.go:318] Caches are synced for crt configmap I0826 00:16:09.593756 1 shared_informer.go:318] Caches are synced for job I0826 00:16:09.593846 1 shared_informer.go:318] Caches are synced for ReplicaSet I0826 00:16:09.594870 1 shared_informer.go:318] Caches are synced for TTL I0826 00:16:09.594948 1 shared_informer.go:318] Caches are synced for endpoint I0826 00:16:09.595088 1 shared_informer.go:318] Caches are synced for TTL after finished I0826 00:16:09.595904 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0826 00:16:09.595994 1 shared_informer.go:318] Caches are synced for PV protection I0826 00:16:09.598382 1 shared_informer.go:318] Caches are synced for service account I0826 00:16:09.602884 1 shared_informer.go:318] Caches are synced for endpoint_slice I0826 00:16:09.699570 1 shared_informer.go:318] Caches are synced for resource quota I0826 00:16:09.703034 1 shared_informer.go:318] Caches are synced for resource quota I0826 00:16:09.791925 1 shared_informer.go:318] Caches are synced for disruption I0826 00:16:09.793421 1 shared_informer.go:318] Caches are synced for deployment I0826 00:16:09.812174 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-x2tj6" I0826 00:16:10.117595 1 shared_informer.go:318] Caches are synced for garbage collector I0826 00:16:10.195136 1 shared_informer.go:318] Caches are synced for garbage collector I0826 00:16:10.195172 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0826 00:16:10.605279 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" I0826 00:16:10.701501 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-pm6pz" I0826 00:16:10.709923 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-825x2" I0826 00:16:10.718811 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="113.763589ms" I0826 00:16:10.725257 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="6.397504ms" I0826 00:16:10.725391 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-7c96b6546b" duration="96.281µs"