2026/02/17 02:23:40 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=af081f32-eab6-45f1-8b38-bee89b332445,--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 02:23:40 Now listening for interrupts
I0217 02:23:40.497995      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:23:40.729701      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:23:40.729758      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:23:40.976728      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:23:41.023220      12 controllermanager.go:160] Version: v1.34.1
I0217 02:23:41.039696      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:23:41.039746      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:23:41.039795      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:23:41.039805      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:23:41.040065      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:23:41.040577      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:23:41.041413      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295020\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295020\" (2026-02-17 01:23:40 +0000 UTC to 2027-02-17 01:23:40 +0000 UTC (now=2026-02-17 02:23:41.041075904 +0000 UTC))"
I0217 02:23:41.042729      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295020\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295020\" (2026-02-17 01:23:40 +0000 UTC to 2029-02-17 01:23:40 +0000 UTC (now=2026-02-17 02:23:41.042713856 +0000 UTC))"
I0217 02:23:41.043342      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:23:41.043148      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:23:41.043476      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:23:41.044128      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:23:41.044697      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:23:41.045319      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:23:41.058686      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:23:41.059154      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-e1u39-8gsrw-w5rcz_ad9402ee-4850-4c99-b063-2b2914f0fc4d became leader"
I0217 02:23:41.065439      12 openstack.go:424] Setting up informers for Cloud
I0217 02:23:41.065635      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:23:41.077648      12 node_controller.go:176] Sending events to api server.
I0217 02:23:41.077661      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:23:41.077821      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:23:41.077971      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:23:41.091398      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:23:41.091630      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:23:41.092152      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:23:41.140951      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:23:41.141020      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:23:41.140994      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:23:41.141476      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 02:18:45 +0000 UTC to 2031-02-16 02:18:45 +0000 UTC (now=2026-02-17 02:23:41.141442682 +0000 UTC))"
I0217 02:23:41.142057      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295020\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295020\" (2026-02-17 01:23:40 +0000 UTC to 2027-02-17 01:23:40 +0000 UTC (now=2026-02-17 02:23:41.142036369 +0000 UTC))"
I0217 02:23:41.142428      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295020\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295020\" (2026-02-17 01:23:40 +0000 UTC to 2029-02-17 01:23:40 +0000 UTC (now=2026-02-17 02:23:41.142409374 +0000 UTC))"
I0217 02:23:41.142618      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 02:18:45 +0000 UTC to 2031-02-16 02:18:45 +0000 UTC (now=2026-02-17 02:23:41.142601407 +0000 UTC))"
I0217 02:23:41.142745      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 02:18:46 +0000 UTC to 2031-02-16 02:18:46 +0000 UTC (now=2026-02-17 02:23:41.142729489 +0000 UTC))"
I0217 02:23:41.143093      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295020\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295020\" (2026-02-17 01:23:40 +0000 UTC to 2027-02-17 01:23:40 +0000 UTC (now=2026-02-17 02:23:41.143078384 +0000 UTC))"
I0217 02:23:41.143413      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295020\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295020\" (2026-02-17 01:23:40 +0000 UTC to 2029-02-17 01:23:40 +0000 UTC (now=2026-02-17 02:23:41.143398788 +0000 UTC))"
I0217 02:23:41.252887      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:23:41.252976      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:23:41.252987      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:23:41.253358      12 controller.go:235] Starting service controller
I0217 02:23:41.253413      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
W0217 02:23:41.273854      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:23:41.273884      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:23:41.273892      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:23:41.277984      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:23:41.278774      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:23:41.279361      12 node_controller.go:429] Initializing node kube-e1u39-8gsrw-w5rcz with cloud provider
I0217 02:23:41.279456      12 node_controller.go:271] Update 1 nodes status took 84.851µs.
I0217 02:23:41.353689      12 shared_informer.go:356] "Caches are synced" controller="service"
I0217 02:23:41.354014      12 controller.go:723] Syncing backends for all LB services.
I0217 02:23:41.354039      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:23:42.106422      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:23:42.106518      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:23:42.106530      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:23:42.106540      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:23:42.106550      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:23:42.106560      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:23:42.135968      12 controller.go:723] Syncing backends for all LB services.
I0217 02:23:42.136010      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:23:42.237533      12 node_controller.go:474] Successfully initialized node kube-e1u39-8gsrw-w5rcz with cloud provider
I0217 02:23:42.237841      12 event.go:389] "Event occurred" object="kube-e1u39-8gsrw-w5rcz" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:23:48.590523      12 controller.go:723] Syncing backends for all LB services.
I0217 02:23:48.590563      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:23:48.590593      12 node_controller.go:429] Initializing node kube-e1u39-default-worker-mv47h-prl8x-krgd5 with cloud provider
I0217 02:23:48.995833      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:23:48.995853      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:23:48.995859      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:23:48.995864      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:23:48.995869      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:23:48.995875      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:23:49.014890      12 controller.go:723] Syncing backends for all LB services.
I0217 02:23:49.014971      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:23:49.065746      12 node_controller.go:474] Successfully initialized node kube-e1u39-default-worker-mv47h-prl8x-krgd5 with cloud provider
I0217 02:23:49.066210      12 event.go:389] "Event occurred" object="kube-e1u39-default-worker-mv47h-prl8x-krgd5" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:23:51.322170      12 controller.go:723] Syncing backends for all LB services.
I0217 02:23:51.322373      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:23:51.322438      12 node_controller.go:429] Initializing node kube-e1u39-default-worker-mv47h-prl8x-q7tpp with cloud provider
I0217 02:23:51.645043      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:23:51.645168      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:23:51.645178      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:23:51.645361      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:23:51.645368      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:23:51.645375      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:23:51.663052      12 controller.go:723] Syncing backends for all LB services.
I0217 02:23:51.663203      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:23:51.692150      12 node_controller.go:474] Successfully initialized node kube-e1u39-default-worker-mv47h-prl8x-q7tpp with cloud provider
I0217 02:23:51.695602      12 event.go:389] "Event occurred" object="kube-e1u39-default-worker-mv47h-prl8x-q7tpp" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:28:42.352335      12 node_controller.go:271] Update 3 nodes status took 1.072523379s.
I0217 02:31:11.481087      12 controller.go:723] Syncing backends for all LB services.
I0217 02:31:11.481125      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:11.550091      12 controller.go:723] Syncing backends for all LB services.
I0217 02:31:11.550167      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:33:43.307091      12 node_controller.go:271] Update 3 nodes status took 954.346099ms.
I0217 02:38:44.573195      12 node_controller.go:271] Update 3 nodes status took 1.264422172s.
I0217 02:43:45.513592      12 node_controller.go:271] Update 3 nodes status took 939.162294ms.
I0217 02:48:46.596560      12 node_controller.go:271] Update 3 nodes status took 1.081629072s.
