2026/02/17 15:16:04 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=23ade74d-9b1d-4114-b514-37ff816d2a7b,--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:16:04 Now listening for interrupts
I0217 15:16:04.855760      12 serving.go:386] Generated self-signed cert in-memory
I0217 15:16:05.092443      12 serving.go:386] Generated self-signed cert in-memory
W0217 15:16:05.092490      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 15:16:05.415354      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 15:16:05.473116      12 controllermanager.go:160] Version: v1.32.1
I0217 15:16:05.479689      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 15:16:05.479721      12 shared_informer.go:313] Waiting for caches to sync for RequestHeaderAuthRequestController
I0217 15:16:05.479793      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:16:05.479806      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 15:16:05.479822      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:16:05.479830      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 15:16:05.480729      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341364\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341364\" (2026-02-17 14:16:04 +0000 UTC to 2027-02-17 14:16:04 +0000 UTC (now=2026-02-17 15:16:05.480704443 +0000 UTC))"
I0217 15:16:05.480928      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341365\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341365\" (2026-02-17 14:16:05 +0000 UTC to 2027-02-17 14:16:05 +0000 UTC (now=2026-02-17 15:16:05.480915526 +0000 UTC))"
I0217 15:16:05.481065      12 secure_serving.go:213] Serving securely on 127.0.0.1:10258
I0217 15:16:05.481464      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 15:16:05.481704      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 15:16:05.482307      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 15:16:05.483025      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 15:16:05.483922      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 15:16:05.499468      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 15:16:05.499605      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-f6br5-dtvbm-pzsht_2a6f6811-0644-4c4e-afb8-8bc09215a672 became leader"
I0217 15:16:05.509279      12 openstack.go:424] Setting up informers for Cloud
I0217 15:16:05.509331      12 controllermanager.go:310] Starting "node-route-controller"
W0217 15:16:05.557899      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 15:16:05.557969      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 15:16:05.557984      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 15:16:05.557996      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 15:16:05.558518      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 15:16:05.558565      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 15:16:05.559253      12 node_controller.go:176] Sending events to api server.
I0217 15:16:05.559736      12 node_controller.go:185] Waiting for informer caches to sync
I0217 15:16:05.559277      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 15:16:05.559342      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 15:16:05.560772      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 15:16:05.562212      12 openstack.go:373] Claiming to support LoadBalancer
I0217 15:16:05.562702      12 controllermanager.go:329] Started "service-lb-controller"
I0217 15:16:05.562770      12 controller.go:234] Starting service controller
I0217 15:16:05.563076      12 shared_informer.go:313] Waiting for caches to sync for service
I0217 15:16:05.568429      12 reflector.go:376] Caches populated for *v1.Node from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 15:16:05.569269      12 reflector.go:376] Caches populated for *v1.Service from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 15:16:05.580547      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 15:16:05.580809      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:10:43 +0000 UTC to 2031-02-16 15:10:43 +0000 UTC (now=2026-02-17 15:16:05.580785499 +0000 UTC))"
I0217 15:16:05.580920      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 15:16:05.581536      12 shared_informer.go:320] Caches are synced for RequestHeaderAuthRequestController
I0217 15:16:05.581423      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341364\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341364\" (2026-02-17 14:16:04 +0000 UTC to 2027-02-17 14:16:04 +0000 UTC (now=2026-02-17 15:16:05.581343727 +0000 UTC))"
I0217 15:16:05.582335      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341365\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341365\" (2026-02-17 14:16:05 +0000 UTC to 2027-02-17 14:16:05 +0000 UTC (now=2026-02-17 15:16:05.582318752 +0000 UTC))"
I0217 15:16:05.582462      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:10:42 +0000 UTC to 2031-02-16 15:10:42 +0000 UTC (now=2026-02-17 15:16:05.582422943 +0000 UTC))"
I0217 15:16:05.582504      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:10:43 +0000 UTC to 2031-02-16 15:10:43 +0000 UTC (now=2026-02-17 15:16:05.582495064 +0000 UTC))"
I0217 15:16:05.583323      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341364\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341364\" (2026-02-17 14:16:04 +0000 UTC to 2027-02-17 14:16:04 +0000 UTC (now=2026-02-17 15:16:05.583307187 +0000 UTC))"
I0217 15:16:05.590790      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341365\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341365\" (2026-02-17 14:16:05 +0000 UTC to 2027-02-17 14:16:05 +0000 UTC (now=2026-02-17 15:16:05.590727635 +0000 UTC))"
I0217 15:16:05.660671      12 node_controller.go:429] Initializing node kube-f6br5-default-worker-5jqwq-wf4x7-dn27m with cloud provider
I0217 15:16:05.660761      12 node_controller.go:271] Update 3 nodes status took 296.224µs.
I0217 15:16:05.665105      12 shared_informer.go:320] Caches are synced for service
I0217 15:16:05.665459      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:05.665794      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:05.665941      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:05.666052      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:05.666178      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:05.666317      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:06.149820      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:16:06.150496      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:16:06.150568      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:16:06.150582      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:16:06.150593      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:16:06.150604      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:16:06.170985      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:06.171582      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:06.239315      12 node_controller.go:474] Successfully initialized node kube-f6br5-default-worker-5jqwq-wf4x7-dn27m with cloud provider
I0217 15:16:06.239427      12 node_controller.go:429] Initializing node kube-f6br5-default-worker-5jqwq-wf4x7-xtn72 with cloud provider
I0217 15:16:06.240301      12 event.go:389] "Event occurred" object="kube-f6br5-default-worker-5jqwq-wf4x7-dn27m" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:16:06.596290      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:16:06.596325      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:16:06.596331      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:16:06.596335      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:16:06.596340      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:16:06.596344      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:16:06.621583      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:06.621639      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:06.642468      12 node_controller.go:474] Successfully initialized node kube-f6br5-default-worker-5jqwq-wf4x7-xtn72 with cloud provider
I0217 15:16:06.642540      12 node_controller.go:429] Initializing node kube-f6br5-dtvbm-pzsht with cloud provider
I0217 15:16:06.646117      12 event.go:389] "Event occurred" object="kube-f6br5-default-worker-5jqwq-wf4x7-xtn72" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:16:07.117599      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:16:07.117644      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:16:07.117649      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:16:07.117654      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:16:07.117658      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:16:07.117663      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:16:07.179354      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:07.181633      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:07.740033      12 node_controller.go:474] Successfully initialized node kube-f6br5-dtvbm-pzsht with cloud provider
I0217 15:16:07.742371      12 event.go:389] "Event occurred" object="kube-f6br5-dtvbm-pzsht" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:21:06.910266      12 node_controller.go:271] Update 3 nodes status took 1.247779806s.
I0217 15:22:25.716507      12 controller.go:722] Syncing backends for all LB services.
I0217 15:22:25.716546      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:22:25.836751      12 controller.go:722] Syncing backends for all LB services.
I0217 15:22:25.836810      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:26:07.930379      12 node_controller.go:271] Update 3 nodes status took 1.019356537s.
I0217 15:31:09.176693      12 node_controller.go:271] Update 3 nodes status took 1.245182569s.
I0217 15:36:10.226395      12 node_controller.go:271] Update 3 nodes status took 1.049371876s.
I0217 15:41:11.503364      12 node_controller.go:271] Update 3 nodes status took 1.276734706s.
