2026/02/16 21:22: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=3cefb1c7-a61e-4ba0-873a-3577a894f2b7,--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:22:20 Now listening for interrupts
I0216 21:22:20.603594      13 serving.go:386] Generated self-signed cert in-memory
I0216 21:22:20.691169      13 serving.go:386] Generated self-signed cert in-memory
W0216 21:22:20.691210      13 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 21:22:20.821229      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 21:22:20.884489      13 controllermanager.go:160] Version: v1.34.1
I0216 21:22:20.951124      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276940\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276940\" (2026-02-16 20:22:20 +0000 UTC to 2027-02-16 20:22:20 +0000 UTC (now=2026-02-16 21:22:20.950972881 +0000 UTC))"
I0216 21:22:20.951154      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 21:22:20.951720      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:22:20.952253      13 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:22:20.951823      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:22:20.952293      13 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:22:20.952562      13 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0216 21:22:20.952134      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276940\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276940\" (2026-02-16 20:22:20 +0000 UTC to 2029-02-16 20:22:20 +0000 UTC (now=2026-02-16 21:22:20.952117068 +0000 UTC))"
I0216 21:22:20.953321      13 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 21:22:20.953560      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 21:22:20.954088      13 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0216 21:22:20.974263      13 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 21:22:20.974293      13 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 21:22:20.978089      13 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 21:22:21.020328      13 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0216 21:22:21.022631      13 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-ddn54-vlrz8-42d7k_e1aea964-0a73-4e7a-95d2-ae030cf2925c became leader"
I0216 21:22:21.025646      13 openstack.go:424] Setting up informers for Cloud
I0216 21:22:21.025721      13 controllermanager.go:310] Starting "cloud-node-controller"
I0216 21:22:21.037319      13 controllermanager.go:329] Started "cloud-node-controller"
I0216 21:22:21.037370      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 21:22:21.037822      13 node_controller.go:176] Sending events to api server.
I0216 21:22:21.038149      13 node_controller.go:185] Waiting for informer caches to sync
I0216 21:22:21.049182      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 21:22:21.049285      13 controllermanager.go:310] Starting "service-lb-controller"
I0216 21:22:21.049778      13 node_lifecycle_controller.go:112] Sending events to api server
I0216 21:22:21.052413      13 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:22:21.052502      13 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:22:21.053300      13 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:15:46 +0000 UTC to 2031-02-15 21:15:46 +0000 UTC (now=2026-02-16 21:22:21.053201337 +0000 UTC))"
I0216 21:22:21.054064      13 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0216 21:22:21.055280      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276940\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276940\" (2026-02-16 20:22:20 +0000 UTC to 2027-02-16 20:22:20 +0000 UTC (now=2026-02-16 21:22:21.05525483 +0000 UTC))"
I0216 21:22:21.055752      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276940\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276940\" (2026-02-16 20:22:20 +0000 UTC to 2029-02-16 20:22:20 +0000 UTC (now=2026-02-16 21:22:21.055679947 +0000 UTC))"
I0216 21:22:21.055934      13 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:15:46 +0000 UTC to 2031-02-15 21:15:46 +0000 UTC (now=2026-02-16 21:22:21.055915397 +0000 UTC))"
I0216 21:22:21.055973      13 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:15:48 +0000 UTC to 2031-02-15 21:15:48 +0000 UTC (now=2026-02-16 21:22:21.055956169 +0000 UTC))"
I0216 21:22:21.056329      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276940\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276940\" (2026-02-16 20:22:20 +0000 UTC to 2027-02-16 20:22:20 +0000 UTC (now=2026-02-16 21:22:21.056310063 +0000 UTC))"
I0216 21:22:21.056673      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276940\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276940\" (2026-02-16 20:22:20 +0000 UTC to 2029-02-16 20:22:20 +0000 UTC (now=2026-02-16 21:22:21.056657497 +0000 UTC))"
I0216 21:22:21.245008      13 openstack.go:373] Claiming to support LoadBalancer
I0216 21:22:21.245398      13 controllermanager.go:329] Started "service-lb-controller"
I0216 21:22:21.245566      13 controllermanager.go:310] Starting "node-route-controller"
I0216 21:22:21.246053      13 controller.go:235] Starting service controller
I0216 21:22:21.246139      13 shared_informer.go:349] "Waiting for caches to sync" controller="service"
W0216 21:22:21.270063      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 21:22:21.270109      13 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 21:22:21.270120      13 controllermanager.go:317] Skipping "node-route-controller"
I0216 21:22:21.275648      13 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 21:22:21.279011      13 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 21:22:21.338883      13 node_controller.go:429] Initializing node kube-ddn54-default-worker-rkkrb-7jt8t-7dhpx with cloud provider
I0216 21:22:21.339333      13 node_controller.go:271] Update 3 nodes status took 116.615µs.
I0216 21:22:21.347134      13 shared_informer.go:356] "Caches are synced" controller="service"
I0216 21:22:21.347206      13 controller.go:723] Syncing backends for all LB services.
I0216 21:22:21.347218      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:22:21.347236      13 controller.go:723] Syncing backends for all LB services.
I0216 21:22:21.347243      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:22:21.347251      13 controller.go:723] Syncing backends for all LB services.
I0216 21:22:21.347256      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:22:21.933551      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:22:21.933606      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:22:21.933617      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:22:21.933625      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:22:21.933635      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:22:21.933644      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:22:21.961853      13 controller.go:723] Syncing backends for all LB services.
I0216 21:22:21.961950      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:22:22.090808      13 node_controller.go:474] Successfully initialized node kube-ddn54-default-worker-rkkrb-7jt8t-7dhpx with cloud provider
I0216 21:22:22.090915      13 node_controller.go:429] Initializing node kube-ddn54-default-worker-rkkrb-7jt8t-ckplt with cloud provider
I0216 21:22:22.091609      13 event.go:389] "Event occurred" object="kube-ddn54-default-worker-rkkrb-7jt8t-7dhpx" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:22:22.585517      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:22:22.585552      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:22:22.585562      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:22:22.585566      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:22:22.585570      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:22:22.585575      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:22:22.821160      13 controller.go:723] Syncing backends for all LB services.
I0216 21:22:22.821503      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:22:23.199188      13 node_controller.go:474] Successfully initialized node kube-ddn54-default-worker-rkkrb-7jt8t-ckplt with cloud provider
I0216 21:22:23.199330      13 node_controller.go:429] Initializing node kube-ddn54-vlrz8-42d7k with cloud provider
I0216 21:22:23.200320      13 event.go:389] "Event occurred" object="kube-ddn54-default-worker-rkkrb-7jt8t-ckplt" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:22:23.619319      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:22:23.619362      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:22:23.619369      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:22:23.619375      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:22:23.619382      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:22:23.619389      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:22:24.066334      13 controller.go:723] Syncing backends for all LB services.
I0216 21:22:24.066355      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:22:24.513564      13 node_controller.go:474] Successfully initialized node kube-ddn54-vlrz8-42d7k with cloud provider
I0216 21:22:24.514193      13 event.go:389] "Event occurred" object="kube-ddn54-vlrz8-42d7k" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:27:22.355907      13 node_controller.go:271] Update 3 nodes status took 1.015399868s.
I0216 21:32:23.367430      13 node_controller.go:271] Update 3 nodes status took 1.010209427s.
I0216 21:35:58.387425      13 controller.go:723] Syncing backends for all LB services.
I0216 21:35:58.387485      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:35:58.458190      13 controller.go:723] Syncing backends for all LB services.
I0216 21:35:58.460905      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:37:24.555174      13 node_controller.go:271] Update 3 nodes status took 1.187509457s.
I0216 21:42:25.562551      13 node_controller.go:271] Update 3 nodes status took 1.006214208s.
I0216 21:47:26.915689      13 node_controller.go:271] Update 3 nodes status took 1.352366179s.
