2026/02/16 21:15:33 Running command:
Command env: (log-file=, also-stdout=false, redirect-stderr=true)
Run from directory: 
Executable path: /bin/openstack-cloud-controller-manager
Args (comma-delimited): /bin/openstack-cloud-controller-manager,--v=2,--cloud-config=/etc/config/cloud.conf,--cluster-name=510e71a6-9097-4ab8-99d7-c426c674b9ef,--cloud-provider=openstack,--use-service-account-credentials=false,--controllers=cloud-node,cloud-node-lifecycle,route,service,--bind-address=127.0.0.1
2026/02/16 21:15:33 Now listening for interrupts
I0216 21:15:34.352460      12 serving.go:386] Generated self-signed cert in-memory
I0216 21:15:35.091341      12 serving.go:386] Generated self-signed cert in-memory
W0216 21:15:35.091397      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 21:15:35.567140      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 21:15:35.626727      12 controllermanager.go:160] Version: v1.33.1
I0216 21:15:35.634591      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276534\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276533\" (2026-02-16 20:15:33 +0000 UTC to 2027-02-16 20:15:33 +0000 UTC (now=2026-02-16 21:15:35.634566627 +0000 UTC))"
I0216 21:15:35.634772      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276535\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276535\" (2026-02-16 20:15:35 +0000 UTC to 2029-02-16 20:15:35 +0000 UTC (now=2026-02-16 21:15:35.634761259 +0000 UTC))"
I0216 21:15:35.634795      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 21:15:35.635395      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0216 21:15:35.636376      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 21:15:35.636397      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0216 21:15:35.636417      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 21:15:35.636576      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:15:35.636585      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:15:35.636594      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:15:35.636598      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:15:35.639644      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:15:35.641189      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:15:35.643753      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:15:35.650933      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0216 21:15:35.653268      12 event.go:389] "Event occurred" object="kube-system/cloud-controller-manager" fieldPath="" kind="Lease" apiVersion="coordination.k8s.io/v1" type="Normal" reason="LeaderElection" message="kube-8mi3t-2vz57-m2nvt_e6d10e15-3365-4aed-aafc-d5ae560c6d22 became leader"
I0216 21:15:35.654867      12 openstack.go:424] Setting up informers for Cloud
I0216 21:15:35.654914      12 controllermanager.go:310] Starting "node-route-controller"
W0216 21:15:35.711693      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 21:15:35.711912      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 21:15:35.711986      12 controllermanager.go:317] Skipping "node-route-controller"
I0216 21:15:35.712039      12 controllermanager.go:310] Starting "cloud-node-controller"
I0216 21:15:35.713846      12 controllermanager.go:329] Started "cloud-node-controller"
I0216 21:15:35.713904      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 21:15:35.714229      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 21:15:35.714262      12 controllermanager.go:310] Starting "service-lb-controller"
I0216 21:15:35.714686      12 openstack.go:373] Claiming to support LoadBalancer
I0216 21:15:35.714775      12 controllermanager.go:329] Started "service-lb-controller"
I0216 21:15:35.715326      12 node_controller.go:176] Sending events to api server.
I0216 21:15:35.715414      12 node_lifecycle_controller.go:112] Sending events to api server
I0216 21:15:35.715495      12 node_controller.go:185] Waiting for informer caches to sync
I0216 21:15:35.715582      12 controller.go:234] Starting service controller
I0216 21:15:35.715617      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
I0216 21:15:35.718691      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:15:35.721939      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:15:35.736701      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:15:35.736706      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:15:35.736976      12 tlsconfig.go:181] "Loaded client CA" index=0 certName="client-ca::kube-system::extension-apiserver-authentication::client-ca-file,client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file" certDetail="\"k8s-cluster\" [] issuer=\"<self>\" (2026-02-15 21:10:29 +0000 UTC to 2031-02-15 21:10:29 +0000 UTC (now=2026-02-16 21:15:35.736959133 +0000 UTC))"
I0216 21:15:35.737057      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0216 21:15:35.737392      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276534\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276533\" (2026-02-16 20:15:33 +0000 UTC to 2027-02-16 20:15:33 +0000 UTC (now=2026-02-16 21:15:35.737381118 +0000 UTC))"
I0216 21:15:35.737619      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276535\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276535\" (2026-02-16 20:15:35 +0000 UTC to 2029-02-16 20:15:35 +0000 UTC (now=2026-02-16 21:15:35.73760987 +0000 UTC))"
I0216 21:15:35.737684      12 tlsconfig.go:181] "Loaded client CA" index=0 certName="client-ca::kube-system::extension-apiserver-authentication::client-ca-file,client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file" certDetail="\"k8s-cluster\" [] issuer=\"<self>\" (2026-02-15 21:10:29 +0000 UTC to 2031-02-15 21:10:29 +0000 UTC (now=2026-02-16 21:15:35.737677211 +0000 UTC))"
I0216 21:15:35.737698      12 tlsconfig.go:181] "Loaded client CA" index=1 certName="client-ca::kube-system::extension-apiserver-authentication::client-ca-file,client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file" certDetail="\"k8s-cluster\" [] issuer=\"<self>\" (2026-02-15 21:10:31 +0000 UTC to 2031-02-15 21:10:31 +0000 UTC (now=2026-02-16 21:15:35.737693831 +0000 UTC))"
I0216 21:15:35.737875      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276534\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276533\" (2026-02-16 20:15:33 +0000 UTC to 2027-02-16 20:15:33 +0000 UTC (now=2026-02-16 21:15:35.737867043 +0000 UTC))"
I0216 21:15:35.738029      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276535\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276535\" (2026-02-16 20:15:35 +0000 UTC to 2029-02-16 20:15:35 +0000 UTC (now=2026-02-16 21:15:35.738021055 +0000 UTC))"
I0216 21:15:35.816647      12 shared_informer.go:357] "Caches are synced" controller="service"
I0216 21:15:35.816743      12 controller.go:722] Syncing backends for all LB services.
I0216 21:15:35.816758      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:35.816948      12 node_controller.go:429] Initializing node kube-8mi3t-2vz57-m2nvt with cloud provider
I0216 21:15:35.817132      12 node_controller.go:271] Update 1 nodes status took 102.211µs.
I0216 21:15:36.348307      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:36.348326      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:36.348333      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:36.348375      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:36.348382      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:36.348387      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:36.381121      12 controller.go:722] Syncing backends for all LB services.
I0216 21:15:36.381157      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:36.426351      12 node_controller.go:474] Successfully initialized node kube-8mi3t-2vz57-m2nvt with cloud provider
I0216 21:15:36.426701      12 event.go:389] "Event occurred" object="kube-8mi3t-2vz57-m2nvt" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:15:45.034933      12 controller.go:722] Syncing backends for all LB services.
I0216 21:15:45.034987      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:45.035034      12 node_controller.go:429] Initializing node kube-8mi3t-default-worker-6hnmb-rb46r-h6rbd with cloud provider
I0216 21:15:45.584801      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:45.584888      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:45.584902      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:45.584910      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:45.584918      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:45.584926      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:45.600344      12 controller.go:722] Syncing backends for all LB services.
I0216 21:15:45.602209      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:45.648601      12 node_controller.go:474] Successfully initialized node kube-8mi3t-default-worker-6hnmb-rb46r-h6rbd with cloud provider
I0216 21:15:45.648949      12 event.go:389] "Event occurred" object="kube-8mi3t-default-worker-6hnmb-rb46r-h6rbd" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:15:46.186039      12 controller.go:722] Syncing backends for all LB services.
I0216 21:15:46.186078      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:46.186111      12 node_controller.go:429] Initializing node kube-8mi3t-default-worker-6hnmb-rb46r-8jpsp with cloud provider
I0216 21:15:46.744486      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:46.744688      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:46.744726      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:46.744755      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:46.744807      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:46.744897      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:46.855667      12 controller.go:722] Syncing backends for all LB services.
I0216 21:15:46.855896      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:46.925121      12 node_controller.go:474] Successfully initialized node kube-8mi3t-default-worker-6hnmb-rb46r-8jpsp with cloud provider
I0216 21:15:46.925837      12 event.go:389] "Event occurred" object="kube-8mi3t-default-worker-6hnmb-rb46r-8jpsp" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:20:37.076381      12 node_controller.go:271] Update 3 nodes status took 1.258478165s.
I0216 21:24:43.507660      12 controller.go:722] Syncing backends for all LB services.
I0216 21:24:43.507748      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:24:43.617910      12 controller.go:722] Syncing backends for all LB services.
I0216 21:24:43.617938      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:25:38.149252      12 node_controller.go:271] Update 3 nodes status took 1.071401467s.
I0216 21:30:39.398953      12 node_controller.go:271] Update 3 nodes status took 1.24950788s.
I0216 21:35:40.525416      12 node_controller.go:271] Update 3 nodes status took 1.125799414s.
I0216 21:40:41.836473      12 node_controller.go:271] Update 3 nodes status took 1.310514212s.
