2026/02/16 21:15:30 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=abcde3ba-bff8-4889-98e3-120568ab6e91,--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:30 Now listening for interrupts
I0216 21:15:30.902547      12 serving.go:386] Generated self-signed cert in-memory
I0216 21:15:31.066968      12 serving.go:386] Generated self-signed cert in-memory
W0216 21:15:31.067061      12 client_config.go:682] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 21:15:31.591061      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 21:15:31.643598      12 controllermanager.go:160] Version: v1.35.0
I0216 21:15:31.652169      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 21:15:31.652234      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276530\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276530\" (2026-02-16 20:15:30 +0000 UTC to 2027-02-16 20:15:30 +0000 UTC (now=2026-02-16 21:15:31.652203152 +0000 UTC))"
I0216 21:15:31.652246      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:15:31.652264      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:31.652251      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:31.652671      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:15:31.652909      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:31.654847      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276531\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276531\" (2026-02-16 20:15:31 +0000 UTC to 2029-02-16 20:15:31 +0000 UTC (now=2026-02-16 21:15:31.65482444 +0000 UTC))"
I0216 21:15:31.655065      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 21:15:31.655272      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 21:15:31.655675      12 leaderelection.go:258] "Attempting to acquire leader lease..." lock="kube-system/cloud-controller-manager"
I0216 21:15:31.658864      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:31.658915      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:31.659553      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:31.673179      12 leaderelection.go:272] "Successfully acquired lease" lock="kube-system/cloud-controller-manager"
I0216 21:15:31.674642      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-sp8f6-9v6wz-gk2lq_2ce0a33c-e02c-410f-bf75-1a3fc406f98d became leader"
I0216 21:15:31.679564      12 openstack.go:424] Setting up informers for Cloud
I0216 21:15:31.680117      12 controllermanager.go:310] Starting "node-route-controller"
W0216 21:15:31.737180      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 21:15:31.737852      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:31.738261      12 controllermanager.go:317] Skipping "node-route-controller"
I0216 21:15:31.739320      12 controllermanager.go:310] Starting "cloud-node-controller"
I0216 21:15:31.749946      12 controllermanager.go:329] Started "cloud-node-controller"
I0216 21:15:31.750420      12 node_controller.go:176] Sending events to api server.
I0216 21:15:31.750548      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 21:15:31.750868      12 node_controller.go:185] Waiting for informer caches to sync
I0216 21:15:31.753014      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:31.753678      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:31.754173      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:18 +0000 UTC to 2031-02-15 21:10:18 +0000 UTC (now=2026-02-16 21:15:31.754145423 +0000 UTC))"
I0216 21:15:31.754196      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:31.755417      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276530\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276530\" (2026-02-16 20:15:30 +0000 UTC to 2027-02-16 20:15:30 +0000 UTC (now=2026-02-16 21:15:31.755393316 +0000 UTC))"
I0216 21:15:31.755930      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276531\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276531\" (2026-02-16 20:15:31 +0000 UTC to 2029-02-16 20:15:31 +0000 UTC (now=2026-02-16 21:15:31.755896921 +0000 UTC))"
I0216 21:15:31.756243      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:18 +0000 UTC to 2031-02-15 21:10:18 +0000 UTC (now=2026-02-16 21:15:31.756232354 +0000 UTC))"
I0216 21:15:31.756327      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:19 +0000 UTC to 2031-02-15 21:10:19 +0000 UTC (now=2026-02-16 21:15:31.756318945 +0000 UTC))"
I0216 21:15:31.756786      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276530\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276530\" (2026-02-16 20:15:30 +0000 UTC to 2027-02-16 20:15:30 +0000 UTC (now=2026-02-16 21:15:31.75677565 +0000 UTC))"
I0216 21:15:31.757189      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276531\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276531\" (2026-02-16 20:15:31 +0000 UTC to 2029-02-16 20:15:31 +0000 UTC (now=2026-02-16 21:15:31.757176934 +0000 UTC))"
I0216 21:15:31.762886      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 21:15:31.763026      12 controllermanager.go:310] Starting "service-lb-controller"
I0216 21:15:31.763367      12 node_lifecycle_controller.go:112] Sending events to api server
I0216 21:15:31.787401      12 openstack.go:373] Claiming to support LoadBalancer
I0216 21:15:31.788653      12 controller.go:235] Starting service controller
I0216 21:15:31.789299      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:31.789843      12 controllermanager.go:329] Started "service-lb-controller"
I0216 21:15:31.797036      12 reflector.go:446] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:31.798102      12 reflector.go:446] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:31.851421      12 node_controller.go:429] Initializing node kube-sp8f6-9v6wz-gk2lq with cloud provider
I0216 21:15:31.851600      12 node_controller.go:271] Update 1 nodes status took 197.322µs.
I0216 21:15:31.890675      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:31.890761      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:31.890777      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:32.382801      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:32.382866      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:32.382878      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:32.382888      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:32.382897      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:32.382907      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:32.402722      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:32.402761      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:32.527776      12 node_controller.go:474] Successfully initialized node kube-sp8f6-9v6wz-gk2lq with cloud provider
I0216 21:15:32.535945      12 event.go:389] "Event occurred" object="kube-sp8f6-9v6wz-gk2lq" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:15:33.071638      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:33.071656      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:33.071681      12 node_controller.go:429] Initializing node kube-sp8f6-default-worker-zbrzb-whv2l-hpwgd with cloud provider
I0216 21:15:33.587508      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:33.587531      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:33.587537      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:33.587543      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:33.587549      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:33.587555      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:33.605647      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:33.605664      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:33.623426      12 node_controller.go:474] Successfully initialized node kube-sp8f6-default-worker-zbrzb-whv2l-hpwgd with cloud provider
I0216 21:15:33.623515      12 event.go:389] "Event occurred" object="kube-sp8f6-default-worker-zbrzb-whv2l-hpwgd" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:15:34.685780      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:34.685832      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:34.685864      12 node_controller.go:429] Initializing node kube-sp8f6-default-worker-zbrzb-whv2l-zzm6m with cloud provider
I0216 21:15:35.304007      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:35.304330      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:35.304337      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:35.304343      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:35.304348      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:35.304352      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:35.317568      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:35.317585      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:35.340237      12 node_controller.go:474] Successfully initialized node kube-sp8f6-default-worker-zbrzb-whv2l-zzm6m with cloud provider
I0216 21:15:35.340568      12 event.go:389] "Event occurred" object="kube-sp8f6-default-worker-zbrzb-whv2l-zzm6m" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:20:32.986876      12 node_controller.go:271] Update 3 nodes status took 1.134973005s.
I0216 21:25:33.910207      12 node_controller.go:271] Update 3 nodes status took 922.162618ms.
I0216 21:29:25.104657      12 controller.go:723] Syncing backends for all LB services.
I0216 21:29:25.104728      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:29:25.208084      12 controller.go:723] Syncing backends for all LB services.
I0216 21:29:25.208320      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:30:35.075044      12 node_controller.go:271] Update 3 nodes status took 1.163625603s.
I0216 21:35:36.054152      12 node_controller.go:271] Update 3 nodes status took 978.108091ms.
I0216 21:40:37.123234      12 node_controller.go:271] Update 3 nodes status took 1.068169999s.
