I0609 09:49:04.781171 1 serving.go:386] Generated self-signed cert in-memory I0609 09:49:05.640449 1 controllermanager.go:185] "Starting" version="v1.32.10" I0609 09:49:05.640472 1 controllermanager.go:187] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0609 09:49:05.641781 1 dynamic_cafile_content.go:161] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0609 09:49:05.641907 1 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" I0609 09:49:05.642416 1 secure_serving.go:213] Serving securely on [::]:10257 I0609 09:49:05.642528 1 tlsconfig.go:243] "Starting DynamicServingCertificateController" I0609 09:49:05.642774 1 leaderelection.go:257] attempting to acquire leader lease kube-system/kube-controller-manager... E0609 09:49:05.652767 1 leaderelection.go:436] 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" I0609 09:49:08.883937 1 leaderelection.go:271] successfully acquired lease kube-system/kube-controller-manager I0609 09:49:08.884272 1 event.go:389] "Event occurred" object="kube-system/kube-controller-manager" fieldPath="" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="instance_f29701d0-13cb-40a0-9c69-5a326fedbf76 became leader" I0609 09:49:08.888586 1 controllermanager.go:765] "Started controller" controller="serviceaccount-token-controller" I0609 09:49:08.888690 1 shared_informer.go:313] Waiting for caches to sync for tokens I0609 09:49:08.899016 1 controllermanager.go:765] "Started controller" controller="token-cleaner-controller" I0609 09:49:08.899177 1 tokencleaner.go:117] "Starting token cleaner controller" logger="token-cleaner-controller" I0609 09:49:08.899209 1 shared_informer.go:313] Waiting for caches to sync for token_cleaner I0609 09:49:08.899225 1 shared_informer.go:320] Caches are synced for token_cleaner I0609 09:49:08.905104 1 node_lifecycle_controller.go:432] "Controller will reconcile labels" logger="node-lifecycle-controller" I0609 09:49:08.905185 1 controllermanager.go:765] "Started controller" controller="node-lifecycle-controller" I0609 09:49:08.905343 1 node_lifecycle_controller.go:466] "Sending events to api server" logger="node-lifecycle-controller" I0609 09:49:08.905383 1 node_lifecycle_controller.go:477] "Starting node controller" logger="node-lifecycle-controller" I0609 09:49:08.905398 1 shared_informer.go:313] Waiting for caches to sync for taint I0609 09:49:08.912501 1 controllermanager.go:765] "Started controller" controller="endpointslice-controller" I0609 09:49:08.912741 1 endpointslice_controller.go:281] "Starting endpoint slice controller" logger="endpointslice-controller" I0609 09:49:08.912768 1 shared_informer.go:313] Waiting for caches to sync for endpoint_slice I0609 09:49:08.919336 1 controllermanager.go:765] "Started controller" controller="endpointslice-mirroring-controller" I0609 09:49:08.919532 1 endpointslicemirroring_controller.go:227] "Starting EndpointSliceMirroring controller" logger="endpointslice-mirroring-controller" I0609 09:49:08.919594 1 shared_informer.go:313] Waiting for caches to sync for endpoint_slice_mirroring I0609 09:49:08.926487 1 controllermanager.go:765] "Started controller" controller="serviceaccount-controller" I0609 09:49:08.926613 1 serviceaccounts_controller.go:114] "Starting service account controller" logger="serviceaccount-controller" I0609 09:49:08.926641 1 shared_informer.go:313] Waiting for caches to sync for service account I0609 09:49:08.934496 1 controllermanager.go:765] "Started controller" controller="job-controller" I0609 09:49:08.934636 1 job_controller.go:243] "Starting job controller" logger="job-controller" I0609 09:49:08.934668 1 shared_informer.go:313] Waiting for caches to sync for job I0609 09:49:08.943475 1 controllermanager.go:765] "Started controller" controller="deployment-controller" I0609 09:49:08.943636 1 deployment_controller.go:173] "Starting controller" logger="deployment-controller" controller="deployment" I0609 09:49:08.943655 1 shared_informer.go:313] Waiting for caches to sync for deployment I0609 09:49:08.955904 1 controllermanager.go:765] "Started controller" controller="horizontal-pod-autoscaler-controller" I0609 09:49:08.955963 1 horizontal.go:201] "Starting HPA controller" logger="horizontal-pod-autoscaler-controller" I0609 09:49:08.955982 1 shared_informer.go:313] Waiting for caches to sync for HPA I0609 09:49:08.989640 1 shared_informer.go:320] Caches are synced for tokens I0609 09:49:08.991947 1 controllermanager.go:765] "Started controller" controller="disruption-controller" I0609 09:49:08.992044 1 disruption.go:452] "Sending events to api server." logger="disruption-controller" I0609 09:49:08.992137 1 disruption.go:463] "Starting disruption controller" logger="disruption-controller" I0609 09:49:08.992157 1 shared_informer.go:313] Waiting for caches to sync for disruption I0609 09:49:09.139278 1 controllermanager.go:765] "Started controller" controller="pod-garbage-collector-controller" I0609 09:49:09.139346 1 gc_controller.go:99] "Starting GC controller" logger="pod-garbage-collector-controller" I0609 09:49:09.139355 1 shared_informer.go:313] Waiting for caches to sync for GC I0609 09:49:09.293516 1 controllermanager.go:765] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0609 09:49:09.293661 1 cleaner.go:83] "Starting CSR cleaner controller" logger="certificatesigningrequest-cleaner-controller" I0609 09:49:09.446710 1 controllermanager.go:765] "Started controller" controller="persistentvolume-attach-detach-controller" I0609 09:49:09.446926 1 attach_detach_controller.go:338] "Starting attach detach controller" logger="persistentvolume-attach-detach-controller" I0609 09:49:09.446943 1 shared_informer.go:313] Waiting for caches to sync for attach detach I0609 09:49:09.590550 1 controllermanager.go:765] "Started controller" controller="persistentvolumeclaim-protection-controller" I0609 09:49:09.590586 1 pvc_protection_controller.go:168] "Starting PVC protection controller" logger="persistentvolumeclaim-protection-controller" I0609 09:49:09.590602 1 shared_informer.go:313] Waiting for caches to sync for PVC protection I0609 09:49:09.739981 1 controllermanager.go:765] "Started controller" controller="persistentvolume-protection-controller" I0609 09:49:09.740019 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="volumeattributesclass-protection-controller" requiredFeatureGates=["VolumeAttributesClass"] I0609 09:49:09.740058 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="storageversion-garbage-collector-controller" requiredFeatureGates=["APIServerIdentity","StorageVersionAPI"] I0609 09:49:09.740201 1 pv_protection_controller.go:81] "Starting PV protection controller" logger="persistentvolume-protection-controller" I0609 09:49:09.740238 1 shared_informer.go:313] Waiting for caches to sync for PV protection I0609 09:49:09.893498 1 controllermanager.go:765] "Started controller" controller="replicationcontroller-controller" I0609 09:49:09.893635 1 replica_set.go:217] "Starting controller" logger="replicationcontroller-controller" name="replicationcontroller" I0609 09:49:09.893660 1 shared_informer.go:313] Waiting for caches to sync for ReplicationController I0609 09:49:10.137438 1 controllermanager.go:765] "Started controller" controller="garbage-collector-controller" I0609 09:49:10.137470 1 garbagecollector.go:144] "Starting controller" logger="garbage-collector-controller" controller="garbagecollector" I0609 09:49:10.137556 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0609 09:49:10.137639 1 graph_builder.go:351] "Running" logger="garbage-collector-controller" component="GraphBuilder" I0609 09:49:10.395508 1 controllermanager.go:765] "Started controller" controller="statefulset-controller" I0609 09:49:10.395677 1 stateful_set.go:166] "Starting stateful set controller" logger="statefulset-controller" I0609 09:49:10.395704 1 shared_informer.go:313] Waiting for caches to sync for stateful set I0609 09:49:10.541989 1 controllermanager.go:765] "Started controller" controller="ttl-controller" I0609 09:49:10.542078 1 ttl_controller.go:127] "Starting TTL controller" logger="ttl-controller" I0609 09:49:10.542130 1 shared_informer.go:313] Waiting for caches to sync for TTL I0609 09:49:10.704905 1 controllermanager.go:765] "Started controller" controller="persistentvolume-binder-controller" I0609 09:49:10.705078 1 pv_controller_base.go:308] "Starting persistent volume controller" logger="persistentvolume-binder-controller" I0609 09:49:10.705100 1 shared_informer.go:313] Waiting for caches to sync for persistent volume I0609 09:49:11.124343 1 controllermanager.go:765] "Started controller" controller="legacy-serviceaccount-token-cleaner-controller" I0609 09:49:11.124389 1 legacy_serviceaccount_token_cleaner.go:103] "Starting legacy service account token cleaner controller" logger="legacy-serviceaccount-token-cleaner-controller" I0609 09:49:11.124419 1 shared_informer.go:313] Waiting for caches to sync for legacy-service-account-token-cleaner I0609 09:49:11.571994 1 controllermanager.go:765] "Started controller" controller="validatingadmissionpolicy-status-controller" I0609 09:49:11.572031 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="selinux-warning-controller" requiredFeatureGates=["SELinuxChangePolicy"] I0609 09:49:11.572097 1 shared_informer.go:313] Waiting for caches to sync for validatingadmissionpolicy-status I0609 09:49:11.581440 1 controllermanager.go:765] "Started controller" controller="replicaset-controller" I0609 09:49:11.581661 1 replica_set.go:217] "Starting controller" logger="replicaset-controller" name="replicaset" I0609 09:49:11.581687 1 shared_informer.go:313] Waiting for caches to sync for ReplicaSet I0609 09:49:11.589917 1 controllermanager.go:765] "Started controller" controller="cronjob-controller" I0609 09:49:11.589950 1 controllermanager.go:723] "Skipping a cloud provider controller" controller="cloud-node-lifecycle-controller" I0609 09:49:11.590233 1 cronjob_controllerv2.go:145] "Starting cronjob controller v2" logger="cronjob-controller" I0609 09:49:11.590269 1 shared_informer.go:313] Waiting for caches to sync for cronjob I0609 09:49:11.598339 1 controllermanager.go:765] "Started controller" controller="persistentvolume-expander-controller" I0609 09:49:11.598361 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="resourceclaim-controller" requiredFeatureGates=["DynamicResourceAllocation"] I0609 09:49:11.598473 1 expand_controller.go:329] "Starting expand controller" logger="persistentvolume-expander-controller" I0609 09:49:11.598502 1 shared_informer.go:313] Waiting for caches to sync for expand I0609 09:49:11.640923 1 controllermanager.go:765] "Started controller" controller="endpoints-controller" I0609 09:49:11.641212 1 endpoints_controller.go:182] "Starting endpoint controller" logger="endpoints-controller" I0609 09:49:11.641241 1 shared_informer.go:313] Waiting for caches to sync for endpoint I0609 09:49:11.947807 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="controllerrevisions.apps" I0609 09:49:11.947931 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="deployments.apps" I0609 09:49:11.948117 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="rolebindings.rbac.authorization.k8s.io" I0609 09:49:11.948171 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="leases.coordination.k8s.io" I0609 09:49:11.948235 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="limitranges" I0609 09:49:11.948325 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="replicasets.apps" I0609 09:49:11.948380 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="networkpolicies.networking.k8s.io" I0609 09:49:11.948425 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="roles.rbac.authorization.k8s.io" I0609 09:49:11.948568 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="horizontalpodautoscalers.autoscaling" I0609 09:49:11.948626 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="cronjobs.batch" I0609 09:49:11.948670 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ingresses.networking.k8s.io" I0609 09:49:11.948709 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="daemonsets.apps" I0609 09:49:11.948771 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="statefulsets.apps" I0609 09:49:11.948847 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="csistoragecapacities.storage.k8s.io" I0609 09:49:11.948911 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpointslices.discovery.k8s.io" I0609 09:49:11.948969 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="podtemplates" W0609 09:49:11.949033 1 shared_informer.go:597] resyncPeriod 12h52m41.295163863s is smaller than resyncCheckPeriod 13h16m1.017520767s and the informer has already started. Changing it to 13h16m1.017520767s I0609 09:49:11.949149 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="jobs.batch" I0609 09:49:11.949245 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="endpoints" I0609 09:49:11.949344 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="serviceaccounts" I0609 09:49:11.949415 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="poddisruptionbudgets.policy" I0609 09:49:11.949584 1 resource_quota_controller.go:300] "Starting resource quota controller" logger="resourcequota-controller" I0609 09:49:11.949621 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0609 09:49:11.949650 1 resource_quota_monitor.go:308] "QuotaMonitor running" logger="resourcequota-controller" I0609 09:49:11.949788 1 controllermanager.go:765] "Started controller" controller="resourcequota-controller" I0609 09:49:12.197884 1 controllermanager.go:765] "Started controller" controller="namespace-controller" I0609 09:49:12.197929 1 namespace_controller.go:202] "Starting namespace controller" logger="namespace-controller" I0609 09:49:12.198047 1 shared_informer.go:313] Waiting for caches to sync for namespace I0609 09:49:12.341251 1 controllermanager.go:765] "Started controller" controller="daemonset-controller" I0609 09:49:12.341413 1 daemon_controller.go:294] "Starting daemon sets controller" logger="daemonset-controller" I0609 09:49:12.341462 1 shared_informer.go:313] Waiting for caches to sync for daemon sets I0609 09:49:12.398387 1 controllermanager.go:765] "Started controller" controller="certificatesigningrequest-approving-controller" I0609 09:49:12.398454 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-approving-controller" name="csrapproving" I0609 09:49:12.398605 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrapproving I0609 09:49:12.439373 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-serving" I0609 09:49:12.439418 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0609 09:49:12.439531 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0609 09:49:12.440449 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kubelet-client" I0609 09:49:12.440476 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0609 09:49:12.440671 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0609 09:49:12.441335 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-kube-apiserver-client" I0609 09:49:12.441362 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0609 09:49:12.441391 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0609 09:49:12.442160 1 controllermanager.go:765] "Started controller" controller="certificatesigningrequest-signing-controller" I0609 09:49:12.442202 1 controllermanager.go:723] "Skipping a cloud provider controller" controller="service-lb-controller" I0609 09:49:12.442212 1 controllermanager.go:723] "Skipping a cloud provider controller" controller="node-route-controller" I0609 09:49:12.442348 1 certificate_controller.go:120] "Starting certificate controller" logger="certificatesigningrequest-signing-controller" name="csrsigning-legacy-unknown" I0609 09:49:12.442402 1 shared_informer.go:313] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0609 09:49:12.442446 1 dynamic_serving_content.go:135] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0609 09:49:12.591421 1 controllermanager.go:765] "Started controller" controller="clusterrole-aggregation-controller" I0609 09:49:12.591456 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="kube-apiserver-serving-clustertrustbundle-publisher-controller" requiredFeatureGates=["ClusterTrustBundle"] I0609 09:49:12.591528 1 clusterroleaggregation_controller.go:194] "Starting ClusterRoleAggregator controller" logger="clusterrole-aggregation-controller" I0609 09:49:12.591544 1 shared_informer.go:313] Waiting for caches to sync for ClusterRoleAggregator I0609 09:49:12.739104 1 controllermanager.go:765] "Started controller" controller="ephemeral-volume-controller" I0609 09:49:12.739131 1 controllermanager.go:717] "Controller is disabled by a feature gate" controller="service-cidr-controller" requiredFeatureGates=["MultiCIDRServiceAllocator"] I0609 09:49:12.739145 1 controller.go:173] "Starting ephemeral volume controller" logger="ephemeral-volume-controller" I0609 09:49:12.739212 1 shared_informer.go:313] Waiting for caches to sync for ephemeral I0609 09:49:12.889987 1 controllermanager.go:765] "Started controller" controller="bootstrap-signer-controller" I0609 09:49:12.890013 1 controllermanager.go:743] "Warning: skipping controller" controller="node-ipam-controller" I0609 09:49:12.890051 1 shared_informer.go:313] Waiting for caches to sync for bootstrap_signer I0609 09:49:13.039715 1 controllermanager.go:765] "Started controller" controller="ttl-after-finished-controller" I0609 09:49:13.039836 1 ttlafterfinished_controller.go:112] "Starting TTL after finished controller" logger="ttl-after-finished-controller" I0609 09:49:13.039859 1 shared_informer.go:313] Waiting for caches to sync for TTL after finished I0609 09:49:13.191059 1 controllermanager.go:765] "Started controller" controller="root-ca-certificate-publisher-controller" I0609 09:49:13.191162 1 publisher.go:107] "Starting root CA cert publisher controller" logger="root-ca-certificate-publisher-controller" I0609 09:49:13.191192 1 shared_informer.go:313] Waiting for caches to sync for crt configmap I0609 09:49:13.238633 1 controllermanager.go:765] "Started controller" controller="taint-eviction-controller" I0609 09:49:13.238692 1 controllermanager.go:743] "Warning: skipping controller" controller="storage-version-migrator-controller" I0609 09:49:13.238688 1 taint_eviction.go:281] "Starting" logger="taint-eviction-controller" controller="taint-eviction-controller" I0609 09:49:13.238785 1 taint_eviction.go:287] "Sending events to api server" logger="taint-eviction-controller" I0609 09:49:13.238942 1 shared_informer.go:313] Waiting for caches to sync for taint-eviction-controller I0609 09:49:13.244404 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0609 09:49:13.256299 1 shared_informer.go:320] Caches are synced for HPA I0609 09:49:13.256300 1 actual_state_of_world.go:541] "Failed to update statusUpdateNeeded field in actual state of world" logger="persistentvolume-attach-detach-controller" err="Failed to set statusUpdateNeeded to needed true, because nodeName=\"instance\" does not exist" I0609 09:49:13.259145 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0609 09:49:13.273232 1 shared_informer.go:320] Caches are synced for validatingadmissionpolicy-status I0609 09:49:13.281852 1 shared_informer.go:320] Caches are synced for ReplicaSet I0609 09:49:13.290955 1 shared_informer.go:320] Caches are synced for cronjob I0609 09:49:13.291055 1 shared_informer.go:320] Caches are synced for bootstrap_signer I0609 09:49:13.291140 1 shared_informer.go:320] Caches are synced for PVC protection I0609 09:49:13.291245 1 shared_informer.go:320] Caches are synced for crt configmap I0609 09:49:13.291656 1 shared_informer.go:320] Caches are synced for ClusterRoleAggregator I0609 09:49:13.292817 1 shared_informer.go:320] Caches are synced for disruption I0609 09:49:13.294010 1 shared_informer.go:320] Caches are synced for ReplicationController I0609 09:49:13.296382 1 shared_informer.go:320] Caches are synced for stateful set I0609 09:49:13.298653 1 shared_informer.go:320] Caches are synced for namespace I0609 09:49:13.299224 1 shared_informer.go:320] Caches are synced for certificate-csrapproving I0609 09:49:13.299707 1 shared_informer.go:320] Caches are synced for expand I0609 09:49:13.306075 1 shared_informer.go:320] Caches are synced for persistent volume I0609 09:49:13.306095 1 shared_informer.go:320] Caches are synced for taint I0609 09:49:13.306163 1 node_lifecycle_controller.go:1234] "Initializing eviction metric for zone" logger="node-lifecycle-controller" zone="" I0609 09:49:13.306260 1 node_lifecycle_controller.go:886] "Missing timestamp for Node. Assuming now as a timestamp" logger="node-lifecycle-controller" node="instance" I0609 09:49:13.306313 1 node_lifecycle_controller.go:1038] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" logger="node-lifecycle-controller" I0609 09:49:13.313545 1 shared_informer.go:320] Caches are synced for endpoint_slice I0609 09:49:13.319834 1 shared_informer.go:320] Caches are synced for endpoint_slice_mirroring I0609 09:49:13.325174 1 shared_informer.go:320] Caches are synced for legacy-service-account-token-cleaner I0609 09:49:13.327404 1 shared_informer.go:320] Caches are synced for service account I0609 09:49:13.334740 1 shared_informer.go:320] Caches are synced for job I0609 09:49:13.338425 1 shared_informer.go:320] Caches are synced for garbage collector I0609 09:49:13.338453 1 garbagecollector.go:154] "Garbage collector: all resource monitors have synced" logger="garbage-collector-controller" I0609 09:49:13.338464 1 garbagecollector.go:157] "Proceeding to collect garbage" logger="garbage-collector-controller" I0609 09:49:13.339476 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-kubelet-serving I0609 09:49:13.339596 1 shared_informer.go:320] Caches are synced for ephemeral I0609 09:49:13.339639 1 shared_informer.go:320] Caches are synced for GC I0609 09:49:13.339666 1 shared_informer.go:320] Caches are synced for taint-eviction-controller I0609 09:49:13.339916 1 shared_informer.go:320] Caches are synced for TTL after finished I0609 09:49:13.340780 1 shared_informer.go:320] Caches are synced for PV protection I0609 09:49:13.340826 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-kubelet-client I0609 09:49:13.342130 1 shared_informer.go:320] Caches are synced for daemon sets I0609 09:49:13.342183 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-kube-apiserver-client I0609 09:49:13.342286 1 shared_informer.go:320] Caches are synced for TTL I0609 09:49:13.343241 1 shared_informer.go:320] Caches are synced for endpoint I0609 09:49:13.343786 1 shared_informer.go:320] Caches are synced for deployment I0609 09:49:13.344407 1 shared_informer.go:320] Caches are synced for certificate-csrsigning-legacy-unknown I0609 09:49:13.347530 1 shared_informer.go:320] Caches are synced for attach detach I0609 09:49:13.349730 1 shared_informer.go:320] Caches are synced for resource quota I0609 09:49:13.352987 1 shared_informer.go:320] Caches are synced for resource quota I0609 09:49:13.360190 1 shared_informer.go:320] Caches are synced for garbage collector I0609 09:49:14.566975 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="163.153208ms" I0609 09:49:14.580940 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="13.902672ms" I0609 09:49:14.581182 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="167.125µs" I0609 09:49:14.581312 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="64.621µs" I0609 09:49:26.662322 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="19.85975ms" I0609 09:49:26.678782 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="15.558448ms" I0609 09:49:26.679741 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="17.363089ms" E0609 09:49:26.679855 1 replica_set.go:560] "Unhandled Error" err="sync \"kube-system/coredns-5cd68b5dbf\" failed with Operation cannot be fulfilled on replicasets.apps \"coredns-5cd68b5dbf\": the object has been modified; please apply your changes to the latest version and try again" logger="UnhandledError" I0609 09:49:26.696800 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="17.974386ms" I0609 09:49:26.696952 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="94.193µs" I0609 09:49:26.698050 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="16.790593ms" I0609 09:49:26.704176 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="6.094472ms" I0609 09:49:26.704395 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="182.205µs" I0609 09:49:38.479924 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="20.60777ms" I0609 09:49:38.493530 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="13.563542ms" I0609 09:49:38.494113 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="549.166µs" I0609 09:49:38.494234 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="102.903µs" I0609 09:49:38.529284 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="86.063µs" I0609 09:49:43.359054 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="securitypolicies.gateway.envoyproxy.io" I0609 09:49:43.359114 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutes.gateway.networking.k8s.io" I0609 09:49:43.359135 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtlspolicies.gateway.networking.k8s.io" I0609 09:49:43.359157 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tlsroutes.gateway.networking.k8s.io" I0609 09:49:43.359182 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backendtrafficpolicies.gateway.envoyproxy.io" I0609 09:49:43.359206 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoypatchpolicies.gateway.envoyproxy.io" I0609 09:49:43.359223 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="tcproutes.gateway.networking.k8s.io" I0609 09:49:43.359246 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="clienttrafficpolicies.gateway.envoyproxy.io" I0609 09:49:43.359264 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="backends.gateway.envoyproxy.io" I0609 09:49:43.359280 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyproxies.gateway.envoyproxy.io" I0609 09:49:43.359296 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="envoyextensionpolicies.gateway.envoyproxy.io" I0609 09:49:43.359313 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="grpcroutes.gateway.networking.k8s.io" I0609 09:49:43.359333 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="referencegrants.gateway.networking.k8s.io" I0609 09:49:43.359353 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="udproutes.gateway.networking.k8s.io" I0609 09:49:43.359367 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xbackendtrafficpolicies.gateway.networking.x-k8s.io" I0609 09:49:43.359385 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="gateways.gateway.networking.k8s.io" I0609 09:49:43.359399 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="httproutefilters.gateway.envoyproxy.io" I0609 09:49:43.359415 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="xlistenersets.gateway.networking.x-k8s.io" I0609 09:49:43.360616 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0609 09:49:43.368773 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0609 09:49:45.260712 1 shared_informer.go:320] Caches are synced for resource quota I0609 09:49:45.369526 1 shared_informer.go:320] Caches are synced for garbage collector I0609 09:49:47.818593 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="0s" I0609 09:49:49.040684 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:49:49.061003 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:49:49.061071 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:49:50.526166 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="83.523µs" I0609 09:49:50.571344 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="12.851801ms" I0609 09:49:50.571417 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/cilium-operator-646c4c79cc" duration="38.981µs" I0609 09:49:55.325733 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="95.352µs" I0609 09:49:55.326151 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="25.461µs" I0609 09:49:55.332880 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="57.352µs" I0609 09:49:55.340192 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:49:55.357565 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:49:55.370520 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="119.963µs" I0609 09:49:57.371224 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="128.985µs" I0609 09:49:57.379325 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="95.633µs" I0609 09:49:58.312946 1 node_lifecycle_controller.go:1057] "Controller detected that some Nodes are Ready. Exiting master disruption mode" logger="node-lifecycle-controller" I0609 09:50:01.389571 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="94.603µs" I0609 09:50:01.595830 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="77.883µs" I0609 09:50:01.620772 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="9.409885ms" I0609 09:50:01.620879 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="69.123µs" I0609 09:50:02.372437 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="80.692µs" I0609 09:50:05.030562 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:50:05.615558 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:50:06.808490 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:50:07.819949 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:50:07.833085 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="1s" I0609 09:50:07.925023 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="21.431743ms" I0609 09:50:07.933364 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="8.295394ms" I0609 09:50:07.933529 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="106.193µs" I0609 09:50:07.937692 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="42.601µs" I0609 09:50:09.634323 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="86.982µs" I0609 09:50:11.331698 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="76.001µs" I0609 09:50:11.354023 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="76.012µs" I0609 09:50:11.376032 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="76.063µs" I0609 09:50:12.644621 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="63.542µs" I0609 09:50:12.670972 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="12.169043ms" I0609 09:50:12.671067 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="61.781µs" I0609 09:50:12.682691 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="7.953284ms" I0609 09:50:12.682782 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-5cd68b5dbf" duration="58.802µs" I0609 09:50:12.704551 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="25.573129ms" I0609 09:50:12.712671 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="8.091238ms" I0609 09:50:12.712779 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="83.382µs" I0609 09:50:15.267169 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumendpoints.cilium.io" I0609 09:50:15.267204 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnetworkpolicies.cilium.io" I0609 09:50:15.267216 1 resource_quota_monitor.go:227] "QuotaMonitor created object count evaluator" logger="resourcequota-controller" resource="ciliumnodeconfigs.cilium.io" I0609 09:50:15.267267 1 shared_informer.go:313] Waiting for caches to sync for resource quota I0609 09:50:15.383866 1 shared_informer.go:313] Waiting for caches to sync for garbage collector I0609 09:50:16.368249 1 shared_informer.go:320] Caches are synced for resource quota I0609 09:50:16.484542 1 shared_informer.go:320] Caches are synced for garbage collector I0609 09:50:17.948174 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="65.462µs" I0609 09:50:18.671361 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="94.943µs" I0609 09:50:18.675912 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/coredns-67d79cf957" duration="59.391µs" I0609 09:50:20.652310 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="8.749676ms" I0609 09:50:20.652771 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="envoy-gateway-system/envoy-gateway-8b6d98d9b" duration="59.081µs" I0609 09:50:37.045841 1 job_controller.go:604] "enqueueing job" logger="job-controller" key="envoy-gateway-system/envoy-gateway-gateway-helm-certgen" delay="0s" I0609 09:51:17.867589 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="25.696115ms" I0609 09:51:17.877729 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="10.091811ms" I0609 09:51:17.880855 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="3.061855ms" I0609 09:51:17.900487 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="60.111µs" I0609 09:51:46.958583 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="11.078888ms" I0609 09:51:46.958840 1 replica_set.go:679] "Finished syncing" logger="replicaset-controller" kind="ReplicaSet" key="kube-system/ceph-csi-rbd-provisioner-846c7587b6" duration="187.706µs" I0609 09:55:24.725903 1 reconciler.go:360] "attacherDetacher.AttachVolume started" logger="persistentvolume-attach-detach-controller" volumeName="kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4395e643-04e2-48f0-928f-0de51278925f" nodeName="instance" scheduledPods=["default/test-pvc-pod"] I0609 09:55:25.254986 1 operation_generator.go:298] AttachVolume.Attach succeeded for volume "pvc-e81aaab1-1ecd-4db2-b8b3-5e9e672f16fc" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4395e643-04e2-48f0-928f-0de51278925f") from node "instance" I0609 09:55:46.992006 1 reconciler.go:275] "attacherDetacher.DetachVolume started" logger="persistentvolume-attach-detach-controller" node="instance" volumeName="kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4395e643-04e2-48f0-928f-0de51278925f" I0609 09:55:46.994729 1 operation_generator.go:1516] Verified volume is safe to detach for volume "pvc-e81aaab1-1ecd-4db2-b8b3-5e9e672f16fc" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4395e643-04e2-48f0-928f-0de51278925f") on node "instance" I0609 09:55:47.542826 1 operation_generator.go:414] DetachVolume.Detach succeeded for volume "pvc-e81aaab1-1ecd-4db2-b8b3-5e9e672f16fc" (UniqueName: "kubernetes.io/csi/rbd.csi.ceph.com^0001-0024-4837cbf8-4f90-4300-b3f6-726c9b9f89b4-0000000000000002-4395e643-04e2-48f0-928f-0de51278925f") on node "instance"