I0128 01:06:20.676194 1 serving.go:348] Generated self-signed cert in-memory I0128 01:06:21.225678 1 controllermanager.go:189] "Starting" version="v1.28.13" I0128 01:06:21.225748 1 controllermanager.go:191] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" I0128 01:06:21.227082 1 secure_serving.go:213] Serving securely on [::]:10257 I0128 01:06:21.227207 1 tlsconfig.go:240] "Starting DynamicServingCertificateController" I0128 01:06:21.227350 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/etc/kubernetes/pki/front-proxy-ca.crt" I0128 01:06:21.227416 1 leaderelection.go:250] attempting to acquire leader lease kube-system/kube-controller-manager... I0128 01:06:21.227553 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" E0128 01:06:22.386864 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" I0128 01:06:26.796869 1 leaderelection.go:260] successfully acquired lease kube-system/kube-controller-manager I0128 01:06:26.797359 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_ca8fe228-bfe2-4383-88c9-3223c7bf2926 became leader" I0128 01:06:26.821839 1 shared_informer.go:311] Waiting for caches to sync for tokens I0128 01:06:26.837758 1 controllermanager.go:642] "Started controller" controller="persistentvolume-expander-controller" I0128 01:06:26.837917 1 expand_controller.go:328] "Starting expand controller" I0128 01:06:26.837929 1 shared_informer.go:311] Waiting for caches to sync for expand I0128 01:06:26.856778 1 controllermanager.go:642] "Started controller" controller="ephemeral-volume-controller" I0128 01:06:26.856999 1 controller.go:169] "Starting ephemeral volume controller" I0128 01:06:26.857014 1 shared_informer.go:311] Waiting for caches to sync for ephemeral I0128 01:06:26.893864 1 controllermanager.go:642] "Started controller" controller="endpointslice-controller" I0128 01:06:26.894338 1 endpointslice_controller.go:264] "Starting endpoint slice controller" I0128 01:06:26.894363 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice I0128 01:06:26.912742 1 controllermanager.go:642] "Started controller" controller="deployment-controller" I0128 01:06:26.913002 1 deployment_controller.go:168] "Starting controller" controller="deployment" I0128 01:06:26.913021 1 shared_informer.go:311] Waiting for caches to sync for deployment I0128 01:06:26.922897 1 shared_informer.go:318] Caches are synced for tokens I0128 01:06:26.932521 1 controllermanager.go:642] "Started controller" controller="replicaset-controller" I0128 01:06:26.932787 1 replica_set.go:214] "Starting controller" name="replicaset" I0128 01:06:26.932805 1 shared_informer.go:311] Waiting for caches to sync for ReplicaSet E0128 01:06:26.956405 1 core.go:92] "Failed to start service controller" err="WARNING: no cloud provider provided, services of type LoadBalancer will fail" I0128 01:06:26.956431 1 controllermanager.go:620] "Warning: skipping controller" controller="service-lb-controller" E0128 01:06:26.963598 1 core.go:213] "Failed to start cloud node lifecycle controller" err="no cloud provider provided" I0128 01:06:26.963626 1 controllermanager.go:620] "Warning: skipping controller" controller="cloud-node-lifecycle-controller" I0128 01:06:26.977603 1 controllermanager.go:642] "Started controller" controller="token-cleaner-controller" I0128 01:06:26.977662 1 tokencleaner.go:112] "Starting token cleaner controller" I0128 01:06:26.977788 1 shared_informer.go:311] Waiting for caches to sync for token_cleaner I0128 01:06:26.977796 1 shared_informer.go:318] Caches are synced for token_cleaner I0128 01:06:27.001794 1 controllermanager.go:642] "Started controller" controller="ttl-after-finished-controller" I0128 01:06:27.001927 1 ttlafterfinished_controller.go:109] "Starting TTL after finished controller" I0128 01:06:27.002057 1 shared_informer.go:311] Waiting for caches to sync for TTL after finished I0128 01:06:27.009502 1 controllermanager.go:642] "Started controller" controller="endpoints-controller" I0128 01:06:27.009677 1 endpoints_controller.go:177] "Starting endpoint controller" I0128 01:06:27.009980 1 shared_informer.go:311] Waiting for caches to sync for endpoint I0128 01:06:27.015592 1 controllermanager.go:642] "Started controller" controller="daemonset-controller" I0128 01:06:27.015742 1 daemon_controller.go:291] "Starting daemon sets controller" I0128 01:06:27.015833 1 shared_informer.go:311] Waiting for caches to sync for daemon sets I0128 01:06:27.300692 1 controllermanager.go:642] "Started controller" controller="horizontal-pod-autoscaler-controller" I0128 01:06:27.300745 1 horizontal.go:200] "Starting HPA controller" I0128 01:06:27.300754 1 shared_informer.go:311] Waiting for caches to sync for HPA I0128 01:06:27.452196 1 controllermanager.go:642] "Started controller" controller="statefulset-controller" I0128 01:06:27.452260 1 stateful_set.go:163] "Starting stateful set controller" I0128 01:06:27.452267 1 shared_informer.go:311] Waiting for caches to sync for stateful set I0128 01:06:27.601931 1 controllermanager.go:642] "Started controller" controller="bootstrap-signer-controller" I0128 01:06:27.601992 1 shared_informer.go:311] Waiting for caches to sync for bootstrap_signer I0128 01:06:27.752247 1 controllermanager.go:642] "Started controller" controller="persistentvolumeclaim-protection-controller" I0128 01:06:27.752326 1 pvc_protection_controller.go:102] "Starting PVC protection controller" I0128 01:06:27.752333 1 shared_informer.go:311] Waiting for caches to sync for PVC protection I0128 01:06:27.906415 1 controllermanager.go:642] "Started controller" controller="persistentvolume-protection-controller" I0128 01:06:27.906703 1 pv_protection_controller.go:78] "Starting PV protection controller" I0128 01:06:27.906900 1 shared_informer.go:311] Waiting for caches to sync for PV protection I0128 01:06:28.091241 1 controllermanager.go:642] "Started controller" controller="replicationcontroller-controller" I0128 01:06:28.091656 1 replica_set.go:214] "Starting controller" name="replicationcontroller" I0128 01:06:28.091962 1 shared_informer.go:311] Waiting for caches to sync for ReplicationController I0128 01:06:28.205819 1 controllermanager.go:642] "Started controller" controller="pod-garbage-collector-controller" I0128 01:06:28.206225 1 gc_controller.go:101] "Starting GC controller" I0128 01:06:28.206475 1 shared_informer.go:311] Waiting for caches to sync for GC I0128 01:06:28.461567 1 controllermanager.go:642] "Started controller" controller="namespace-controller" I0128 01:06:28.461880 1 controllermanager.go:620] "Warning: skipping controller" controller="node-ipam-controller" I0128 01:06:28.461999 1 core.go:224] "Will not configure cloud provider routes for allocate-node-cidrs" CIDRs=false routes=true I0128 01:06:28.462127 1 controllermanager.go:620] "Warning: skipping controller" controller="node-route-controller" I0128 01:06:28.461854 1 namespace_controller.go:197] "Starting namespace controller" I0128 01:06:28.462336 1 shared_informer.go:311] Waiting for caches to sync for namespace I0128 01:06:28.604420 1 controllermanager.go:642] "Started controller" controller="endpointslice-mirroring-controller" I0128 01:06:28.609572 1 endpointslicemirroring_controller.go:223] "Starting EndpointSliceMirroring controller" I0128 01:06:28.609805 1 shared_informer.go:311] Waiting for caches to sync for endpoint_slice_mirroring I0128 01:06:28.754602 1 controllermanager.go:642] "Started controller" controller="serviceaccount-controller" I0128 01:06:28.754678 1 serviceaccounts_controller.go:111] "Starting service account controller" I0128 01:06:28.755125 1 shared_informer.go:311] Waiting for caches to sync for service account I0128 01:06:29.001651 1 garbagecollector.go:155] "Starting controller" controller="garbagecollector" I0128 01:06:29.001698 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0128 01:06:29.001744 1 graph_builder.go:294] "Running" component="GraphBuilder" I0128 01:06:29.002060 1 controllermanager.go:642] "Started controller" controller="garbage-collector-controller" I0128 01:06:29.256728 1 controllermanager.go:642] "Started controller" controller="clusterrole-aggregation-controller" I0128 01:06:29.256821 1 clusterroleaggregation_controller.go:189] "Starting ClusterRoleAggregator controller" I0128 01:06:29.256865 1 shared_informer.go:311] Waiting for caches to sync for ClusterRoleAggregator I0128 01:06:29.555547 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="limitranges" I0128 01:06:29.555790 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="controllerrevisions.apps" I0128 01:06:29.555857 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="replicasets.apps" I0128 01:06:29.555918 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="statefulsets.apps" I0128 01:06:29.555997 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="csistoragecapacities.storage.k8s.io" I0128 01:06:29.556028 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpoints" I0128 01:06:29.556217 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="poddisruptionbudgets.policy" I0128 01:06:29.556278 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="roles.rbac.authorization.k8s.io" I0128 01:06:29.556334 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="endpointslices.discovery.k8s.io" I0128 01:06:29.556406 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="podtemplates" I0128 01:06:29.556458 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="rolebindings.rbac.authorization.k8s.io" I0128 01:06:29.556528 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="leases.coordination.k8s.io" I0128 01:06:29.556581 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="daemonsets.apps" I0128 01:06:29.556643 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="jobs.batch" I0128 01:06:29.556677 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="horizontalpodautoscalers.autoscaling" I0128 01:06:29.556752 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="networkpolicies.networking.k8s.io" I0128 01:06:29.556805 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ingresses.networking.k8s.io" I0128 01:06:29.556840 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="deployments.apps" W0128 01:06:29.556891 1 shared_informer.go:593] resyncPeriod 12h10m43.05176151s is smaller than resyncCheckPeriod 22h44m33.762630621s and the informer has already started. Changing it to 22h44m33.762630621s W0128 01:06:29.556968 1 shared_informer.go:593] resyncPeriod 22h36m7.706655897s is smaller than resyncCheckPeriod 22h44m33.762630621s and the informer has already started. Changing it to 22h44m33.762630621s I0128 01:06:29.557096 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="serviceaccounts" I0128 01:06:29.557202 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="cronjobs.batch" I0128 01:06:29.557318 1 controllermanager.go:642] "Started controller" controller="resourcequota-controller" I0128 01:06:29.557508 1 resource_quota_controller.go:294] "Starting resource quota controller" I0128 01:06:29.557936 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0128 01:06:29.558019 1 resource_quota_monitor.go:305] "QuotaMonitor running" I0128 01:06:29.751373 1 controllermanager.go:642] "Started controller" controller="disruption-controller" I0128 01:06:29.751438 1 disruption.go:433] "Sending events to api server." I0128 01:06:29.751647 1 disruption.go:444] "Starting disruption controller" I0128 01:06:29.751660 1 shared_informer.go:311] Waiting for caches to sync for disruption I0128 01:06:29.904112 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-serving" I0128 01:06:29.904165 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-serving I0128 01:06:29.904184 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0128 01:06:29.905253 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kubelet-client" I0128 01:06:29.905267 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kubelet-client I0128 01:06:29.905391 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0128 01:06:29.906150 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-kube-apiserver-client" I0128 01:06:29.906164 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-kube-apiserver-client I0128 01:06:29.906558 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0128 01:06:29.907303 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-signing-controller" I0128 01:06:29.907426 1 certificate_controller.go:115] "Starting certificate controller" name="csrsigning-legacy-unknown" I0128 01:06:29.907438 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrsigning-legacy-unknown I0128 01:06:29.907467 1 dynamic_serving_content.go:132] "Starting controller" name="csr-controller::/etc/kubernetes/pki/ca.crt::/etc/kubernetes/pki/ca.key" I0128 01:06:29.949956 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-cleaner-controller" I0128 01:06:29.950006 1 cleaner.go:83] "Starting CSR cleaner controller" I0128 01:06:30.102647 1 controllermanager.go:642] "Started controller" controller="job-controller" I0128 01:06:30.102708 1 job_controller.go:226] "Starting job controller" I0128 01:06:30.102714 1 shared_informer.go:311] Waiting for caches to sync for job I0128 01:06:30.251612 1 controllermanager.go:642] "Started controller" controller="ttl-controller" I0128 01:06:30.251692 1 ttl_controller.go:124] "Starting TTL controller" I0128 01:06:30.251702 1 shared_informer.go:311] Waiting for caches to sync for TTL I0128 01:06:30.402713 1 controllermanager.go:642] "Started controller" controller="persistentvolume-binder-controller" I0128 01:06:30.403028 1 pv_controller_base.go:319] "Starting persistent volume controller" I0128 01:06:30.403049 1 shared_informer.go:311] Waiting for caches to sync for persistent volume I0128 01:06:30.553412 1 controllermanager.go:642] "Started controller" controller="root-ca-certificate-publisher-controller" I0128 01:06:30.553467 1 publisher.go:102] "Starting root CA cert publisher controller" I0128 01:06:30.553473 1 shared_informer.go:311] Waiting for caches to sync for crt configmap I0128 01:06:30.703834 1 controllermanager.go:642] "Started controller" controller="cronjob-controller" I0128 01:06:30.704007 1 cronjob_controllerv2.go:139] "Starting cronjob controller v2" I0128 01:06:30.704029 1 shared_informer.go:311] Waiting for caches to sync for cronjob I0128 01:06:30.749882 1 controllermanager.go:642] "Started controller" controller="certificatesigningrequest-approving-controller" I0128 01:06:30.749947 1 certificate_controller.go:115] "Starting certificate controller" name="csrapproving" I0128 01:06:30.749954 1 shared_informer.go:311] Waiting for caches to sync for certificate-csrapproving I0128 01:06:30.800498 1 node_lifecycle_controller.go:431] "Controller will reconcile labels" I0128 01:06:30.800725 1 controllermanager.go:642] "Started controller" controller="node-lifecycle-controller" I0128 01:06:30.800933 1 node_lifecycle_controller.go:465] "Sending events to api server" I0128 01:06:30.801097 1 node_lifecycle_controller.go:476] "Starting node controller" I0128 01:06:30.801116 1 shared_informer.go:311] Waiting for caches to sync for taint I0128 01:06:31.526084 1 controllermanager.go:642] "Started controller" controller="persistentvolume-attach-detach-controller" I0128 01:06:31.526955 1 attach_detach_controller.go:337] "Starting attach detach controller" I0128 01:06:31.526972 1 shared_informer.go:311] Waiting for caches to sync for attach detach I0128 01:06:31.537854 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0128 01:06:31.551659 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" I0128 01:06:31.552341 1 shared_informer.go:318] Caches are synced for stateful set I0128 01:06:31.552400 1 shared_informer.go:318] Caches are synced for TTL I0128 01:06:31.554147 1 shared_informer.go:318] Caches are synced for PVC protection I0128 01:06:31.557308 1 shared_informer.go:318] Caches are synced for ClusterRoleAggregator I0128 01:06:31.557361 1 shared_informer.go:318] Caches are synced for ephemeral I0128 01:06:31.557718 1 shared_informer.go:318] Caches are synced for service account I0128 01:06:31.562576 1 shared_informer.go:318] Caches are synced for namespace I0128 01:06:31.577986 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0128 01:06:31.592380 1 shared_informer.go:318] Caches are synced for ReplicationController I0128 01:06:31.600912 1 shared_informer.go:318] Caches are synced for HPA I0128 01:06:31.602167 1 shared_informer.go:318] Caches are synced for TTL after finished I0128 01:06:31.602387 1 shared_informer.go:318] Caches are synced for bootstrap_signer I0128 01:06:31.602741 1 shared_informer.go:318] Caches are synced for job I0128 01:06:31.603214 1 shared_informer.go:318] Caches are synced for persistent volume I0128 01:06:31.608351 1 shared_informer.go:318] Caches are synced for GC I0128 01:06:31.608484 1 shared_informer.go:318] Caches are synced for PV protection I0128 01:06:31.608537 1 shared_informer.go:318] Caches are synced for cronjob I0128 01:06:31.616339 1 shared_informer.go:318] Caches are synced for deployment I0128 01:06:31.616787 1 shared_informer.go:318] Caches are synced for daemon sets I0128 01:06:31.616874 1 shared_informer.go:318] Caches are synced for endpoint I0128 01:06:31.627324 1 shared_informer.go:318] Caches are synced for attach detach I0128 01:06:31.633170 1 shared_informer.go:318] Caches are synced for ReplicaSet I0128 01:06:31.638364 1 shared_informer.go:318] Caches are synced for expand I0128 01:06:31.652949 1 shared_informer.go:318] Caches are synced for disruption I0128 01:06:31.653055 1 shared_informer.go:318] Caches are synced for certificate-csrapproving I0128 01:06:31.654564 1 shared_informer.go:318] Caches are synced for crt configmap I0128 01:06:31.695086 1 shared_informer.go:318] Caches are synced for endpoint_slice I0128 01:06:31.704999 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-serving I0128 01:06:31.705465 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kubelet-client I0128 01:06:31.706296 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-kube-apiserver-client I0128 01:06:31.707458 1 shared_informer.go:318] Caches are synced for certificate-csrsigning-legacy-unknown I0128 01:06:31.712436 1 shared_informer.go:318] Caches are synced for endpoint_slice_mirroring I0128 01:06:31.713284 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-5dd5756b68 to 2" I0128 01:06:31.736875 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-fhv9z" I0128 01:06:31.738170 1 shared_informer.go:318] Caches are synced for resource quota I0128 01:06:31.761847 1 shared_informer.go:318] Caches are synced for resource quota I0128 01:06:31.801719 1 shared_informer.go:318] Caches are synced for taint I0128 01:06:31.801896 1 node_lifecycle_controller.go:1225] "Initializing eviction metric for zone" zone="" I0128 01:06:31.802020 1 node_lifecycle_controller.go:877] "Missing timestamp for Node. Assuming now as a timestamp" node="instance" I0128 01:06:31.802090 1 node_lifecycle_controller.go:1029] "Controller detected that all Nodes are not-Ready. Entering master disruption mode" I0128 01:06:31.802095 1 taint_manager.go:205] "Starting NoExecuteTaintManager" I0128 01:06:31.802203 1 taint_manager.go:210] "Sending events to api server" I0128 01:06:31.802589 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" I0128 01:06:32.117331 1 event.go:307] "Event occurred" object="kube-system/coredns-5dd5756b68" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-5dd5756b68-fzmtc" I0128 01:06:32.125907 1 event.go:307] "Event occurred" object="kube-system/coredns-5dd5756b68" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-5dd5756b68-rpk8w" I0128 01:06:32.141599 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="428.743643ms" I0128 01:06:32.170036 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="28.399859ms" I0128 01:06:32.170205 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="78.99µs" I0128 01:06:32.180168 1 event.go:307] "Event occurred" object="kube-system/kube-vip-instance" fieldPath="" kind="Pod" apiVersion="v1" type="Warning" reason="NodeNotReady" message="Node is not ready" I0128 01:06:32.181601 1 shared_informer.go:318] Caches are synced for garbage collector I0128 01:06:32.186336 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="49.08µs" I0128 01:06:32.201910 1 shared_informer.go:318] Caches are synced for garbage collector I0128 01:06:32.201956 1 garbagecollector.go:166] "All resource monitors have synced. Proceeding to collect garbage" I0128 01:06:38.718460 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-77cccfdc44 to 1" I0128 01:06:38.727363 1 event.go:307] "Event occurred" object="kube-system/coredns-77cccfdc44" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-77cccfdc44-7tjb2" I0128 01:06:38.743646 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="26.145089ms" I0128 01:06:38.763735 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="20.044756ms" I0128 01:06:38.764566 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="33.222µs" I0128 01:06:38.765873 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-5dd5756b68 to 1 from 2" I0128 01:06:38.783562 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-77cccfdc44 to 2 from 1" I0128 01:06:38.794221 1 event.go:307] "Event occurred" object="kube-system/coredns-5dd5756b68" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulDelete" message="Deleted pod: coredns-5dd5756b68-rpk8w" I0128 01:06:38.802063 1 event.go:307] "Event occurred" object="kube-system/coredns-77cccfdc44" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-77cccfdc44-89q58" I0128 01:06:38.818988 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="55.64431ms" I0128 01:06:38.823642 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="41.925578ms" I0128 01:06:38.834671 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="15.610551ms" I0128 01:06:38.834982 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="56.723µs" I0128 01:06:38.837351 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="13.688721ms" I0128 01:06:38.837429 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="32.911µs" I0128 01:06:50.646271 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-7fcd8d6ffd to 1" I0128 01:06:50.903289 1 event.go:307] "Event occurred" object="kube-system/cilium" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-wcc2x" I0128 01:06:50.903951 1 event.go:307] "Event occurred" object="kube-system/cilium-operator-7fcd8d6ffd" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: cilium-operator-7fcd8d6ffd-8kvzs" I0128 01:06:50.941837 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="295.276016ms" I0128 01:06:50.978232 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="36.293026ms" I0128 01:06:50.978447 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="189.297µs" I0128 01:06:57.214390 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-6f56467975 to 1" I0128 01:06:57.242674 1 event.go:307] "Event occurred" object="local-path-storage/local-path-provisioner-6f56467975" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: local-path-provisioner-6f56467975-qg59c" I0128 01:06:57.255454 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="41.988427ms" I0128 01:06:57.262089 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="6.507148ms" I0128 01:06:57.262313 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="59.242µs" I0128 01:07:09.018705 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="125.244µs" I0128 01:07:09.973192 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="19.659599ms" I0128 01:07:09.974012 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/cilium-operator-7fcd8d6ffd" duration="159.825µs" I0128 01:07:12.782971 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="54.081µs" I0128 01:07:12.790038 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="39.111µs" I0128 01:07:12.790250 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="48.451µs" I0128 01:07:12.790276 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="16.85µs" I0128 01:07:12.800374 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="64.802µs" I0128 01:07:12.819328 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="64.981µs" I0128 01:07:12.826662 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="44.231µs" I0128 01:07:12.835994 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="45.322µs" I0128 01:07:16.808380 1 node_lifecycle_controller.go:1048] "Controller detected that some Nodes are Ready. Exiting master disruption mode" I0128 01:07:18.980181 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="41.701µs" I0128 01:07:19.038048 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="36.591257ms" I0128 01:07:19.038298 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="79.842µs" I0128 01:07:19.056051 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="123.613µs" I0128 01:07:20.028376 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="38.839669ms" I0128 01:07:20.052756 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-5dd5756b68 to 0 from 1" I0128 01:07:20.065010 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="36.583428ms" I0128 01:07:20.065230 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-77cccfdc44" duration="76.832µs" I0128 01:07:20.088924 1 event.go:307] "Event occurred" object="kube-system/coredns-5dd5756b68" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulDelete" message="Deleted pod: coredns-5dd5756b68-fzmtc" I0128 01:07:20.115861 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="62.561793ms" I0128 01:07:20.126228 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="10.319042ms" I0128 01:07:20.127308 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="28.651µs" I0128 01:07:21.003963 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="7.392375ms" I0128 01:07:21.004040 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="local-path-storage/local-path-provisioner-6f56467975" duration="48.122µs" I0128 01:07:27.530762 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="38.451µs" I0128 01:07:28.016155 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="43.471µs" I0128 01:07:28.019044 1 replica_set.go:676] "Finished syncing" kind="ReplicaSet" key="kube-system/coredns-5dd5756b68" duration="110.242µs" I0128 01:07:31.748408 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnodeconfigs.cilium.io" I0128 01:07:31.748779 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumnetworkpolicies.cilium.io" I0128 01:07:31.748990 1 resource_quota_monitor.go:224] "QuotaMonitor created object count evaluator" resource="ciliumendpoints.cilium.io" I0128 01:07:31.749180 1 shared_informer.go:311] Waiting for caches to sync for resource quota I0128 01:07:31.850303 1 shared_informer.go:318] Caches are synced for resource quota I0128 01:07:32.194529 1 shared_informer.go:311] Waiting for caches to sync for garbage collector I0128 01:07:32.297441 1 shared_informer.go:318] Caches are synced for garbage collector I0128 01:08:16.794316 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" I0128 01:08:17.425970 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."