2026/02/17 00:59:19 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=1fde67d3-d1f1-4255-a8b5-e5989c55178f,--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 00:59:19 Now listening for interrupts
I0217 00:59:19.820314      12 serving.go:386] Generated self-signed cert in-memory
I0217 00:59:19.976530      12 serving.go:386] Generated self-signed cert in-memory
W0217 00:59:19.976603      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 00:59:20.069897      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 00:59:20.138493      12 controllermanager.go:160] Version: v1.34.1
I0217 00:59:20.152181      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 00:59:20.152433      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 00:59:20.152243      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 00:59:20.152606      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 00:59:20.152213      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 00:59:20.152646      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 00:59:20.154688      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771289959\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771289959\" (2026-02-16 23:59:19 +0000 UTC to 2027-02-16 23:59:19 +0000 UTC (now=2026-02-17 00:59:20.154632356 +0000 UTC))"
I0217 00:59:20.155538      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771289960\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771289960\" (2026-02-16 23:59:19 +0000 UTC to 2029-02-16 23:59:19 +0000 UTC (now=2026-02-17 00:59:20.155523102 +0000 UTC))"
I0217 00:59:20.155812      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 00:59:20.155896      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 00:59:20.156407      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 00:59:20.155872      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 00:59:20.157528      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 00:59:20.158216      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 00:59:20.172631      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 00:59:20.176312      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-l4xi4-s9dqs-5jk97_fde83286-1d52-4baa-8e1b-1748ace89797 became leader"
I0217 00:59:20.180308      12 openstack.go:424] Setting up informers for Cloud
I0217 00:59:20.180361      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 00:59:20.253129      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 00:59:20.253390      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 00:59:20.253749      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 00:59:20.253784      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 00:55:02 +0000 UTC to 2031-02-16 00:55:02 +0000 UTC (now=2026-02-17 00:59:20.253761878 +0000 UTC))"
I0217 00:59:20.254150      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771289959\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771289959\" (2026-02-16 23:59:19 +0000 UTC to 2027-02-16 23:59:19 +0000 UTC (now=2026-02-17 00:59:20.254140934 +0000 UTC))"
I0217 00:59:20.254805      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771289960\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771289960\" (2026-02-16 23:59:19 +0000 UTC to 2029-02-16 23:59:19 +0000 UTC (now=2026-02-17 00:59:20.254645284 +0000 UTC))"
I0217 00:59:20.255005      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 00:55:02 +0000 UTC to 2031-02-16 00:55:02 +0000 UTC (now=2026-02-17 00:59:20.25499398 +0000 UTC))"
I0217 00:59:20.255080      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 00:55:03 +0000 UTC to 2031-02-16 00:55:03 +0000 UTC (now=2026-02-17 00:59:20.255071161 +0000 UTC))"
I0217 00:59:20.255344      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771289959\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771289959\" (2026-02-16 23:59:19 +0000 UTC to 2027-02-16 23:59:19 +0000 UTC (now=2026-02-17 00:59:20.255332795 +0000 UTC))"
I0217 00:59:20.255586      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771289960\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771289960\" (2026-02-16 23:59:19 +0000 UTC to 2029-02-16 23:59:19 +0000 UTC (now=2026-02-17 00:59:20.25557753 +0000 UTC))"
I0217 00:59:20.336570      12 openstack.go:373] Claiming to support LoadBalancer
I0217 00:59:20.337433      12 controllermanager.go:329] Started "service-lb-controller"
I0217 00:59:20.337741      12 controllermanager.go:310] Starting "node-route-controller"
I0217 00:59:20.337855      12 controller.go:235] Starting service controller
I0217 00:59:20.337925      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
W0217 00:59:20.365652      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 00:59:20.365796      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 00:59:20.365825      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 00:59:20.365934      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 00:59:20.376712      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 00:59:20.376802      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 00:59:20.378013      12 node_controller.go:176] Sending events to api server.
I0217 00:59:20.378606      12 node_controller.go:185] Waiting for informer caches to sync
I0217 00:59:20.391837      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 00:59:20.392245      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 00:59:20.397765      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 00:59:20.398730      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 00:59:20.438391      12 shared_informer.go:356] "Caches are synced" controller="service"
I0217 00:59:20.438478      12 controller.go:723] Syncing backends for all LB services.
I0217 00:59:20.438493      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 00:59:20.438511      12 controller.go:723] Syncing backends for all LB services.
I0217 00:59:20.438517      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 00:59:20.438526      12 controller.go:723] Syncing backends for all LB services.
I0217 00:59:20.438532      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 00:59:20.479913      12 node_controller.go:429] Initializing node kube-l4xi4-default-worker-mj27s-w86g9-ct9cf with cloud provider
I0217 00:59:20.480092      12 node_controller.go:271] Update 3 nodes status took 211.923µs.
I0217 00:59:20.969952      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 00:59:20.970028      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 00:59:20.970039      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 00:59:20.970049      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 00:59:20.970058      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 00:59:20.970071      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 00:59:20.981543      12 controller.go:723] Syncing backends for all LB services.
I0217 00:59:20.981591      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 00:59:21.073351      12 node_controller.go:474] Successfully initialized node kube-l4xi4-default-worker-mj27s-w86g9-ct9cf with cloud provider
I0217 00:59:21.073424      12 node_controller.go:429] Initializing node kube-l4xi4-default-worker-mj27s-w86g9-tmqms with cloud provider
I0217 00:59:21.081087      12 event.go:389] "Event occurred" object="kube-l4xi4-default-worker-mj27s-w86g9-ct9cf" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 00:59:21.558301      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 00:59:21.558327      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 00:59:21.558332      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 00:59:21.558336      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 00:59:21.558341      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 00:59:21.558345      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 00:59:21.579922      12 controller.go:723] Syncing backends for all LB services.
I0217 00:59:21.579980      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 00:59:21.622613      12 node_controller.go:474] Successfully initialized node kube-l4xi4-default-worker-mj27s-w86g9-tmqms with cloud provider
I0217 00:59:21.623979      12 event.go:389] "Event occurred" object="kube-l4xi4-default-worker-mj27s-w86g9-tmqms" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 00:59:21.624832      12 node_controller.go:429] Initializing node kube-l4xi4-s9dqs-5jk97 with cloud provider
I0217 00:59:22.008959      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 00:59:22.009084      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 00:59:22.009109      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 00:59:22.009213      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 00:59:22.009247      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 00:59:22.009389      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 00:59:22.027402      12 controller.go:723] Syncing backends for all LB services.
I0217 00:59:22.027973      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 00:59:22.119477      12 node_controller.go:474] Successfully initialized node kube-l4xi4-s9dqs-5jk97 with cloud provider
I0217 00:59:22.119628      12 event.go:389] "Event occurred" object="kube-l4xi4-s9dqs-5jk97" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 01:04:21.544525      12 node_controller.go:271] Update 3 nodes status took 1.062886422s.
I0217 01:08:34.570128      12 controller.go:723] Syncing backends for all LB services.
I0217 01:08:34.570253      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:08:34.690494      12 controller.go:723] Syncing backends for all LB services.
I0217 01:08:34.690534      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:09:22.574956      12 node_controller.go:271] Update 3 nodes status took 1.029133339s.
I0217 01:14:23.587993      12 node_controller.go:271] Update 3 nodes status took 999.839585ms.
I0217 01:19:24.661278      12 node_controller.go:271] Update 3 nodes status took 1.071680781s.
I0217 01:24:25.701290      12 node_controller.go:271] Update 3 nodes status took 1.039739006s.
