2026/02/17 15:16:20 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=6035511a-e210-4bad-a066-48d684912d7a,--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:20 Now listening for interrupts
I0217 15:16:21.396625      12 serving.go:386] Generated self-signed cert in-memory
I0217 15:16:22.438534      12 serving.go:386] Generated self-signed cert in-memory
W0217 15:16:22.438594      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 15:16:23.416552      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 15:16:23.485800      12 controllermanager.go:160] Version: v1.33.1
I0217 15:16:23.494312      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 15:16:23.494408      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:16:23.494451      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:16:23.494411      12 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 15:16:23.494721      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:16:23.494945      12 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:16:23.495296      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341381\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341381\" (2026-02-17 14:16:20 +0000 UTC to 2027-02-17 14:16:20 +0000 UTC (now=2026-02-17 15:16:23.495248291 +0000 UTC))"
I0217 15:16:23.495713      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341383\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341383\" (2026-02-17 14:16:22 +0000 UTC to 2029-02-17 14:16:22 +0000 UTC (now=2026-02-17 15:16:23.495691671 +0000 UTC))"
I0217 15:16:23.495791      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 15:16:23.496251      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 15:16:23.496660      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 15:16:23.498640      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:16:23.498947      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:16:23.501012      12 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:16:23.517779      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 15:16:23.522528      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-jaf5x-l7t9m-hjvvm_48ad4124-b088-4735-abec-99bdb71ecbb6 became leader"
I0217 15:16:23.549605      12 openstack.go:424] Setting up informers for Cloud
I0217 15:16:23.549667      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 15:16:23.550366      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 15:16:23.550399      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 15:16:23.550636      12 node_controller.go:176] Sending events to api server.
I0217 15:16:23.550724      12 node_controller.go:185] Waiting for informer caches to sync
I0217 15:16:23.551167      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 15:16:23.551201      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 15:16:23.551532      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 15:16:23.552148      12 openstack.go:373] Claiming to support LoadBalancer
I0217 15:16:23.552207      12 controllermanager.go:329] Started "service-lb-controller"
I0217 15:16:23.552215      12 controllermanager.go:310] Starting "node-route-controller"
I0217 15:16:23.552739      12 controller.go:234] Starting service controller
I0217 15:16:23.552999      12 shared_informer.go:350] "Waiting for caches to sync" controller="service"
I0217 15:16:23.595596      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 15:16:23.596051      12 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 15:16:23.596715      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:11:32 +0000 UTC to 2031-02-16 15:11:32 +0000 UTC (now=2026-02-17 15:16:23.596621378 +0000 UTC))"
I0217 15:16:23.598174      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341381\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341381\" (2026-02-17 14:16:20 +0000 UTC to 2027-02-17 14:16:20 +0000 UTC (now=2026-02-17 15:16:23.59815229 +0000 UTC))"
I0217 15:16:23.599910      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341383\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341383\" (2026-02-17 14:16:22 +0000 UTC to 2029-02-17 14:16:22 +0000 UTC (now=2026-02-17 15:16:23.599793218 +0000 UTC))"
I0217 15:16:23.600183      12 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 15:16:23.600900      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:11:29 +0000 UTC to 2031-02-16 15:11:29 +0000 UTC (now=2026-02-17 15:16:23.60088512 +0000 UTC))"
I0217 15:16:23.601864      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:11:32 +0000 UTC to 2031-02-16 15:11:32 +0000 UTC (now=2026-02-17 15:16:23.601012806 +0000 UTC))"
I0217 15:16:23.602772      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771341381\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771341381\" (2026-02-17 14:16:20 +0000 UTC to 2027-02-17 14:16:20 +0000 UTC (now=2026-02-17 15:16:23.602757057 +0000 UTC))"
I0217 15:16:23.603180      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771341383\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771341383\" (2026-02-17 14:16:22 +0000 UTC to 2029-02-17 14:16:22 +0000 UTC (now=2026-02-17 15:16:23.603166706 +0000 UTC))"
W0217 15:16:23.605627      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 15:16:23.605662      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:23.605669      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 15:16:23.609981      12 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:16:23.610934      12 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 15:16:23.651263      12 node_controller.go:429] Initializing node kube-jaf5x-l7t9m-hjvvm with cloud provider
I0217 15:16:23.652696      12 node_controller.go:271] Update 1 nodes status took 133.446µs.
I0217 15:16:23.655015      12 shared_informer.go:357] "Caches are synced" controller="service"
I0217 15:16:23.655567      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:23.657347      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:24.086112      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:16:24.086432      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:16:24.086608      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:16:24.086764      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:16:24.086918      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:16:24.087241      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:16:24.129892      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:24.130196      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:24.250020      12 node_controller.go:474] Successfully initialized node kube-jaf5x-l7t9m-hjvvm with cloud provider
I0217 15:16:24.251032      12 event.go:389] "Event occurred" object="kube-jaf5x-l7t9m-hjvvm" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:16:52.317865      12 node_controller.go:429] Initializing node kube-jaf5x-default-worker-2wnxs-kdckd-zzmzn with cloud provider
I0217 15:16:52.319612      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:52.320042      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:52.765331      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:16:52.765396      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:16:52.765410      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:16:52.765422      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:16:52.765435      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:16:52.765447      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:16:52.784072      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:52.784110      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:52.821686      12 node_controller.go:474] Successfully initialized node kube-jaf5x-default-worker-2wnxs-kdckd-zzmzn with cloud provider
I0217 15:16:52.822106      12 event.go:389] "Event occurred" object="kube-jaf5x-default-worker-2wnxs-kdckd-zzmzn" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:16:54.976920      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:54.976991      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:54.977054      12 node_controller.go:429] Initializing node kube-jaf5x-default-worker-2wnxs-kdckd-6x25w with cloud provider
I0217 15:16:55.322098      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 15:16:55.322417      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 15:16:55.322655      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 15:16:55.323073      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 15:16:55.323678      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 15:16:55.323747      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 15:16:55.338316      12 controller.go:722] Syncing backends for all LB services.
I0217 15:16:55.338366      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:16:55.409765      12 node_controller.go:474] Successfully initialized node kube-jaf5x-default-worker-2wnxs-kdckd-6x25w with cloud provider
I0217 15:16:55.410289      12 event.go:389] "Event occurred" object="kube-jaf5x-default-worker-2wnxs-kdckd-6x25w" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 15:21:24.983237      12 node_controller.go:271] Update 3 nodes status took 1.32970684s.
I0217 15:26:26.239421      12 node_controller.go:271] Update 3 nodes status took 1.255370468s.
I0217 15:30:38.280749      12 controller.go:722] Syncing backends for all LB services.
I0217 15:30:38.280791      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:30:38.399828      12 controller.go:722] Syncing backends for all LB services.
I0217 15:30:38.399905      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 15:31:27.470952      12 node_controller.go:271] Update 3 nodes status took 1.230486548s.
I0217 15:36:28.632109      12 node_controller.go:271] Update 3 nodes status took 1.160697986s.
I0217 15:41:29.901335      12 node_controller.go:271] Update 3 nodes status took 1.268314429s.
