2026/02/17 15:20:41 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=be809a49-cb81-4510-9a7d-157f29695062,--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:20:41 Now listening for interrupts
I0217 15:20:41.577276      12 serving.go:386] Generated self-signed cert in-memory
I0217 15:20:41.758873      12 serving.go:386] Generated self-signed cert in-memory
W0217 15:20:41.758926      12 client_config.go:682] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 15:20:42.032161      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 15:20:42.095906      12 controllermanager.go:160] Version: v1.35.0
I0217 15:20:42.105875      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341641\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341641\" (2026-02-17 14:20:41 +0000 UTC to 2027-02-17 14:20:41 +0000 UTC (now=2026-02-17 15:20:42.105786386 +0000 UTC))"
I0217 15:20:42.106295      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341642\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341641\" (2026-02-17 14:20:41 +0000 UTC to 2029-02-17 14:20:41 +0000 UTC (now=2026-02-17 15:20:42.106228051 +0000 UTC))"
I0217 15:20:42.106399      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 15:20:42.106986      12 leaderelection.go:258] "Attempting to acquire leader lease..." lock="kube-system/cloud-controller-manager"
I0217 15:20:42.107657      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:20:42.107742      12 shared_informer.go:370] "Waiting for caches to sync"
I0217 15:20:42.107767      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 15:20:42.108076      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:20:42.108193      12 shared_informer.go:370] "Waiting for caches to sync"
I0217 15:20:42.108699      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 15:20:42.108803      12 shared_informer.go:370] "Waiting for caches to sync"
I0217 15:20:42.115731      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 15:20:42.115980      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 15:20:42.116229      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 15:20:42.128874      12 leaderelection.go:272] "Successfully acquired lease" lock="kube-system/cloud-controller-manager"
I0217 15:20:42.129448      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-1n9mz-pwg5k-5n8d7_6b2aee22-9769-4940-bb11-ca793d42101b became leader"
I0217 15:20:42.134843      12 openstack.go:424] Setting up informers for Cloud
I0217 15:20:42.134942      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 15:20:42.151947      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 15:20:42.153007      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 15:20:42.153174      12 node_controller.go:176] Sending events to api server.
I0217 15:20:42.153836      12 node_controller.go:185] Waiting for informer caches to sync
I0217 15:20:42.165168      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 15:20:42.165219      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 15:20:42.165429      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 15:20:42.208404      12 shared_informer.go:377] "Caches are synced"
I0217 15:20:42.208513      12 shared_informer.go:377] "Caches are synced"
I0217 15:20:42.208851      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:15:20 +0000 UTC to 2031-02-16 15:15:20 +0000 UTC (now=2026-02-17 15:20:42.208822758 +0000 UTC))"
I0217 15:20:42.209321      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341641\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341641\" (2026-02-17 14:20:41 +0000 UTC to 2027-02-17 14:20:41 +0000 UTC (now=2026-02-17 15:20:42.209301532 +0000 UTC))"
I0217 15:20:42.209583      12 shared_informer.go:377] "Caches are synced"
I0217 15:20:42.209699      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341642\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341641\" (2026-02-17 14:20:41 +0000 UTC to 2029-02-17 14:20:41 +0000 UTC (now=2026-02-17 15:20:42.209681497 +0000 UTC))"
I0217 15:20:42.209829      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:15:19 +0000 UTC to 2031-02-16 15:15:19 +0000 UTC (now=2026-02-17 15:20:42.209814546 +0000 UTC))"
I0217 15:20:42.209858      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:15:20 +0000 UTC to 2031-02-16 15:15:20 +0000 UTC (now=2026-02-17 15:20:42.209847785 +0000 UTC))"
I0217 15:20:42.210231      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341641\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341641\" (2026-02-17 14:20:41 +0000 UTC to 2027-02-17 14:20:41 +0000 UTC (now=2026-02-17 15:20:42.210212651 +0000 UTC))"
I0217 15:20:42.210576      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341642\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341641\" (2026-02-17 14:20:41 +0000 UTC to 2029-02-17 14:20:41 +0000 UTC (now=2026-02-17 15:20:42.210561417 +0000 UTC))"
I0217 15:20:42.359175      12 openstack.go:373] Claiming to support LoadBalancer
I0217 15:20:42.359277      12 controllermanager.go:329] Started "service-lb-controller"
I0217 15:20:42.359292      12 controllermanager.go:310] Starting "node-route-controller"
I0217 15:20:42.360895      12 controller.go:235] Starting service controller
I0217 15:20:42.361342      12 shared_informer.go:370] "Waiting for caches to sync"
W0217 15:20:42.388391      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 15:20:42.388509      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 15:20:42.388545      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 15:20:42.402992      12 reflector.go:446] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 15:20:42.403553      12 reflector.go:446] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 15:20:42.455237      12 node_controller.go:271] Update 3 nodes status took 316.006µs.
I0217 15:20:42.455388      12 node_controller.go:429] Initializing node kube-1n9mz-default-worker-p4fs2-ntqqr-jjt86 with cloud provider
I0217 15:20:42.463287      12 shared_informer.go:377] "Caches are synced"
I0217 15:20:42.463421      12 controller.go:723] Syncing backends for all LB services.
I0217 15:20:42.463443      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:20:42.463504      12 controller.go:723] Syncing backends for all LB services.
I0217 15:20:42.463514      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:20:42.463529      12 controller.go:723] Syncing backends for all LB services.
I0217 15:20:42.463539      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:20:42.992548      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:20:42.992616      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:20:42.992627      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:20:42.992636      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:20:42.992645      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:20:42.992654      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:20:43.007088      12 controller.go:723] Syncing backends for all LB services.
I0217 15:20:43.007128      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:20:43.021994      12 node_controller.go:474] Successfully initialized node kube-1n9mz-default-worker-p4fs2-ntqqr-jjt86 with cloud provider
I0217 15:20:43.022493      12 node_controller.go:429] Initializing node kube-1n9mz-default-worker-p4fs2-ntqqr-kjrlh with cloud provider
I0217 15:20:43.023169      12 event.go:389] "Event occurred" object="kube-1n9mz-default-worker-p4fs2-ntqqr-jjt86" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:20:43.498171      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:20:43.498482      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:20:43.498802      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:20:43.499139      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:20:43.499347      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:20:43.499488      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:20:43.515167      12 controller.go:723] Syncing backends for all LB services.
I0217 15:20:43.515268      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:20:43.550970      12 node_controller.go:474] Successfully initialized node kube-1n9mz-default-worker-p4fs2-ntqqr-kjrlh with cloud provider
I0217 15:20:43.551078      12 node_controller.go:429] Initializing node kube-1n9mz-pwg5k-5n8d7 with cloud provider
I0217 15:20:43.551892      12 event.go:389] "Event occurred" object="kube-1n9mz-default-worker-p4fs2-ntqqr-kjrlh" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:20:44.020255      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:20:44.020472      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:20:44.020536      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:20:44.020606      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:20:44.020646      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:20:44.020691      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:20:44.052876      12 controller.go:723] Syncing backends for all LB services.
I0217 15:20:44.052927      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:20:44.207932      12 node_controller.go:474] Successfully initialized node kube-1n9mz-pwg5k-5n8d7 with cloud provider
I0217 15:20:44.208298      12 event.go:389] "Event occurred" object="kube-1n9mz-pwg5k-5n8d7" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:25:43.520865      12 node_controller.go:271] Update 3 nodes status took 1.064897837s.
I0217 15:30:44.510045      12 node_controller.go:271] Update 3 nodes status took 987.932289ms.
I0217 15:35:25.253638      12 controller.go:723] Syncing backends for all LB services.
I0217 15:35:25.254136      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:35:25.327002      12 controller.go:723] Syncing backends for all LB services.
I0217 15:35:25.327041      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:35:45.668878      12 node_controller.go:271] Update 3 nodes status took 1.158277287s.
I0217 15:40:46.756360      12 node_controller.go:271] Update 3 nodes status took 1.086791916s.
I0217 15:45:47.934155      12 node_controller.go:271] Update 3 nodes status took 1.177022178s.
