2026/02/17 02:40:38 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=c4ef403e-9283-400e-93c2-0c75baa83ab3,--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:40:38 Now listening for interrupts
I0217 02:40:39.078491      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:40:39.430014      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:40:39.430070      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:40:39.566931      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:40:39.614688      12 controllermanager.go:160] Version: v1.34.1
I0217 02:40:39.626501      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:40:39.626489      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:40:39.626577      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:40:39.626581      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:40:39.626636      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:40:39.626645      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:40:39.627056      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296039\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296038\" (2026-02-17 01:40:38 +0000 UTC to 2027-02-17 01:40:38 +0000 UTC (now=2026-02-17 02:40:39.627013681 +0000 UTC))"
I0217 02:40:39.627791      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296039\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296039\" (2026-02-17 01:40:39 +0000 UTC to 2029-02-17 01:40:39 +0000 UTC (now=2026-02-17 02:40:39.62776612 +0000 UTC))"
I0217 02:40:39.627986      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:40:39.628090      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:40:39.629088      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:40:39.629353      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:40:39.629440      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:40:39.630997      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:40:39.659871      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:40:39.661070      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-u87sx-dqrhw-8dxkv_d8fdeda8-8cb7-4340-8225-4518aef89b2a became leader"
I0217 02:40:39.664528      12 openstack.go:424] Setting up informers for Cloud
I0217 02:40:39.664605      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:40:39.727066      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:40:39.728177      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:33:34 +0000 UTC to 2031-02-16 02:33:34 +0000 UTC (now=2026-02-17 02:40:39.728075861 +0000 UTC))"
I0217 02:40:39.728290      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:40:39.728314      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:40:39.729584      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296039\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296038\" (2026-02-17 01:40:38 +0000 UTC to 2027-02-17 01:40:38 +0000 UTC (now=2026-02-17 02:40:39.729471151 +0000 UTC))"
I0217 02:40:39.730383      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296039\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296039\" (2026-02-17 01:40:39 +0000 UTC to 2029-02-17 01:40:39 +0000 UTC (now=2026-02-17 02:40:39.730368059 +0000 UTC))"
I0217 02:40:39.730878      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:33:34 +0000 UTC to 2031-02-16 02:33:34 +0000 UTC (now=2026-02-17 02:40:39.730863641 +0000 UTC))"
I0217 02:40:39.731179      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:33:35 +0000 UTC to 2031-02-16 02:33:35 +0000 UTC (now=2026-02-17 02:40:39.731036258 +0000 UTC))"
I0217 02:40:39.731868      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296039\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296038\" (2026-02-17 01:40:38 +0000 UTC to 2027-02-17 01:40:38 +0000 UTC (now=2026-02-17 02:40:39.731804657 +0000 UTC))"
I0217 02:40:39.732180      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296039\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296039\" (2026-02-17 01:40:39 +0000 UTC to 2029-02-17 01:40:39 +0000 UTC (now=2026-02-17 02:40:39.732167673 +0000 UTC))"
W0217 02:40:39.744591      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:40:39.744634      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:40:39.744642      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:40:39.744649      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:40:39.756392      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:40:39.756450      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:40:39.756605      12 node_controller.go:176] Sending events to api server.
I0217 02:40:39.756725      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:40:39.771918      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:40:39.772210      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:40:39.772943      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:40:39.802381      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:40:39.802577      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:40:39.803710      12 controller.go:235] Starting service controller
I0217 02:40:39.803776      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
I0217 02:40:39.809058      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:40:39.810002      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:40:39.857688      12 node_controller.go:429] Initializing node kube-u87sx-default-worker-45s9c-s9ddd-bp9gr with cloud provider
I0217 02:40:39.858364      12 node_controller.go:271] Update 3 nodes status took 612.391µs.
I0217 02:40:39.904211      12 shared_informer.go:356] "Caches are synced" controller="service"
I0217 02:40:39.904304      12 controller.go:723] Syncing backends for all LB services.
I0217 02:40:39.904370      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:39.904390      12 controller.go:723] Syncing backends for all LB services.
I0217 02:40:39.904419      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:39.904430      12 controller.go:723] Syncing backends for all LB services.
I0217 02:40:39.904457      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:40.354288      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:40:40.354456      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:40:40.354500      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:40:40.354591      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:40:40.354662      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:40:40.354695      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:40:40.441714      12 controller.go:723] Syncing backends for all LB services.
I0217 02:40:40.441797      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:40.562499      12 node_controller.go:474] Successfully initialized node kube-u87sx-default-worker-45s9c-s9ddd-bp9gr with cloud provider
I0217 02:40:40.562859      12 node_controller.go:429] Initializing node kube-u87sx-default-worker-45s9c-s9ddd-hfwcx with cloud provider
I0217 02:40:40.563050      12 event.go:389] "Event occurred" object="kube-u87sx-default-worker-45s9c-s9ddd-bp9gr" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:40:41.082762      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:40:41.082788      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:40:41.082794      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:40:41.082800      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:40:41.082806      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:40:41.082812      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:40:41.155609      12 controller.go:723] Syncing backends for all LB services.
I0217 02:40:41.155803      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:41.206437      12 node_controller.go:474] Successfully initialized node kube-u87sx-default-worker-45s9c-s9ddd-hfwcx with cloud provider
I0217 02:40:41.206553      12 node_controller.go:429] Initializing node kube-u87sx-dqrhw-8dxkv with cloud provider
I0217 02:40:41.207033      12 event.go:389] "Event occurred" object="kube-u87sx-default-worker-45s9c-s9ddd-hfwcx" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:40:41.673139      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:40:41.673199      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:40:41.673208      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:40:41.673215      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:40:41.673222      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:40:41.673230      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:40:41.699756      12 controller.go:723] Syncing backends for all LB services.
I0217 02:40:41.699832      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:40:41.802327      12 node_controller.go:474] Successfully initialized node kube-u87sx-dqrhw-8dxkv with cloud provider
I0217 02:40:41.802878      12 event.go:389] "Event occurred" object="kube-u87sx-dqrhw-8dxkv" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:45:41.027922      12 node_controller.go:271] Update 3 nodes status took 1.169204444s.
I0217 02:50:42.050740      12 node_controller.go:271] Update 3 nodes status took 1.022004823s.
I0217 02:53:40.490174      12 controller.go:723] Syncing backends for all LB services.
I0217 02:53:40.490327      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:53:40.605246      12 controller.go:723] Syncing backends for all LB services.
I0217 02:53:40.605311      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:55:43.258323      12 node_controller.go:271] Update 3 nodes status took 1.207260586s.
I0217 03:00:44.248794      12 node_controller.go:271] Update 3 nodes status took 988.429181ms.
I0217 03:05:45.388709      12 node_controller.go:271] Update 3 nodes status took 1.139026771s.
