2026/02/17 15:14:55 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=cc242ed5-df69-44df-baa1-bc1006997ed9,--cloud-provider=openstack,--use-service-account-credentials=false,--controllers=cloud-node,cloud-node-lifecycle,route,service,--bind-address=127.0.0.1
2026/02/17 15:14:55 Now listening for interrupts
I0217 15:14:56.195731      12 serving.go:386] Generated self-signed cert in-memory
I0217 15:14:56.639935      12 serving.go:386] Generated self-signed cert in-memory
W0217 15:14:56.639994      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 15:14:57.579296      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 15:14:57.635022      12 controllermanager.go:160] Version: v1.33.1
I0217 15:14:57.645674      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 15:14:57.645715      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:14:57.645737      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 15:14:57.645744      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:14:57.647920      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341296\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341296\" (2026-02-17 14:14:55 +0000 UTC to 2027-02-17 14:14:55 +0000 UTC (now=2026-02-17 15:14:57.647889275 +0000 UTC))"
I0217 15:14:57.648528      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341297\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341297\" (2026-02-17 14:14:56 +0000 UTC to 2029-02-17 14:14:56 +0000 UTC (now=2026-02-17 15:14:57.648510974 +0000 UTC))"
I0217 15:14:57.648589      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 15:14:57.649486      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 15:14:57.649516      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 15:14:57.651110      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:14:57.651199      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:14:57.652705      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:14:57.653058      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:14:57.655519      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:14:57.667987      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 15:14:57.668493      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-vbp5r-89qkr-r5rqg_5cdfd3ea-b18b-441f-92f6-36f51970bb04 became leader"
I0217 15:14:57.672160      12 openstack.go:424] Setting up informers for Cloud
I0217 15:14:57.672239      12 controllermanager.go:310] Starting "node-route-controller"
W0217 15:14:57.725690      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 15:14:57.725866      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 15:14:57.725877      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 15:14:57.725887      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 15:14:57.726660      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 15:14:57.726674      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 15:14:57.726724      12 node_controller.go:176] Sending events to api server.
I0217 15:14:57.726873      12 node_controller.go:185] Waiting for informer caches to sync
I0217 15:14:57.726934      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 15:14:57.727024      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 15:14:57.727093      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 15:14:57.727595      12 openstack.go:373] Claiming to support LoadBalancer
I0217 15:14:57.727626      12 controllermanager.go:329] Started "service-lb-controller"
I0217 15:14:57.727880      12 controller.go:234] Starting service controller
I0217 15:14:57.727916      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
I0217 15:14:57.733627      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:14:57.733766      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:14:57.746664      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:14:57.746969      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 15:14:57.747166      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-16 15:09:55 +0000 UTC to 2031-02-16 15:09:55 +0000 UTC (now=2026-02-17 15:14:57.747144867 +0000 UTC))"
I0217 15:14:57.747615      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341296\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341296\" (2026-02-17 14:14:55 +0000 UTC to 2027-02-17 14:14:55 +0000 UTC (now=2026-02-17 15:14:57.747601043 +0000 UTC))"
I0217 15:14:57.748010      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341297\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341297\" (2026-02-17 14:14:56 +0000 UTC to 2029-02-17 14:14:56 +0000 UTC (now=2026-02-17 15:14:57.74799585 +0000 UTC))"
I0217 15:14:57.751745      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:14:57.752262      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-16 15:09:55 +0000 UTC to 2031-02-16 15:09:55 +0000 UTC (now=2026-02-17 15:14:57.752233071 +0000 UTC))"
I0217 15:14:57.752480      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-16 15:09:56 +0000 UTC to 2031-02-16 15:09:56 +0000 UTC (now=2026-02-17 15:14:57.752447564 +0000 UTC))"
I0217 15:14:57.753229      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341296\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341296\" (2026-02-17 14:14:55 +0000 UTC to 2027-02-17 14:14:55 +0000 UTC (now=2026-02-17 15:14:57.753201994 +0000 UTC))"
I0217 15:14:57.753973      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341297\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341297\" (2026-02-17 14:14:56 +0000 UTC to 2029-02-17 14:14:56 +0000 UTC (now=2026-02-17 15:14:57.753950805 +0000 UTC))"
I0217 15:14:57.828415      12 node_controller.go:429] Initializing node kube-vbp5r-89qkr-r5rqg with cloud provider
I0217 15:14:57.829015      12 shared_informer.go:357] "Caches are synced" controller="service"
I0217 15:14:57.829042      12 node_controller.go:271] Update 3 nodes status took 817.473µs.
I0217 15:14:57.829619      12 controller.go:722] Syncing backends for all LB services.
I0217 15:14:57.829759      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:14:57.829786      12 controller.go:722] Syncing backends for all LB services.
I0217 15:14:57.829794      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:14:57.829807      12 controller.go:722] Syncing backends for all LB services.
I0217 15:14:57.829814      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:14:58.386965      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:14:58.387031      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:14:58.387038      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:14:58.387045      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:14:58.387051      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:14:58.387059      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:14:58.406744      12 controller.go:722] Syncing backends for all LB services.
I0217 15:14:58.406763      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:14:58.548840      12 node_controller.go:474] Successfully initialized node kube-vbp5r-89qkr-r5rqg with cloud provider
I0217 15:14:58.566923      12 node_controller.go:429] Initializing node kube-vbp5r-default-worker-sq44p-gg55x-pk2c4 with cloud provider
I0217 15:14:58.580935      12 event.go:389] "Event occurred" object="kube-vbp5r-89qkr-r5rqg" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:14:58.965963      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:14:58.965984      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:14:58.965989      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:14:58.965993      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:14:58.965997      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:14:58.966002      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:14:58.988860      12 controller.go:722] Syncing backends for all LB services.
I0217 15:14:58.988903      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:14:59.043733      12 node_controller.go:474] Successfully initialized node kube-vbp5r-default-worker-sq44p-gg55x-pk2c4 with cloud provider
I0217 15:14:59.043837      12 node_controller.go:429] Initializing node kube-vbp5r-default-worker-sq44p-gg55x-q94nh with cloud provider
I0217 15:14:59.044971      12 event.go:389] "Event occurred" object="kube-vbp5r-default-worker-sq44p-gg55x-pk2c4" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:14:59.493522      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:14:59.493558      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:14:59.493563      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:14:59.493567      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:14:59.493571      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:14:59.493577      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:14:59.806920      12 controller.go:722] Syncing backends for all LB services.
I0217 15:14:59.806960      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:15:00.264425      12 node_controller.go:474] Successfully initialized node kube-vbp5r-default-worker-sq44p-gg55x-q94nh with cloud provider
I0217 15:15:00.264742      12 event.go:389] "Event occurred" object="kube-vbp5r-default-worker-sq44p-gg55x-q94nh" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:19:59.040758      12 node_controller.go:271] Update 3 nodes status took 1.210572607s.
I0217 15:25:00.264445      12 node_controller.go:271] Update 3 nodes status took 1.222718375s.
I0217 15:30:01.508502      12 node_controller.go:271] Update 3 nodes status took 1.24322464s.
I0217 15:30:08.348694      12 controller.go:722] Syncing backends for all LB services.
I0217 15:30:08.348741      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:30:08.427362      12 controller.go:722] Syncing backends for all LB services.
I0217 15:30:08.427436      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:35:02.549459      12 node_controller.go:271] Update 3 nodes status took 1.040078103s.
