2026/02/16 21:23:25 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=a382194e-80dc-4073-8036-be628a23ee59,--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:23:25 Now listening for interrupts
I0216 21:23:26.467887      13 serving.go:386] Generated self-signed cert in-memory
I0216 21:23:26.911063      13 serving.go:386] Generated self-signed cert in-memory
W0216 21:23:26.911141      13 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 21:23:27.457304      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 21:23:27.516256      13 controllermanager.go:160] Version: v1.33.1
I0216 21:23:27.529162      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771277006\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771277006\" (2026-02-16 20:23:25 +0000 UTC to 2027-02-16 20:23:25 +0000 UTC (now=2026-02-16 21:23:27.529064077 +0000 UTC))"
I0216 21:23:27.529226      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:23:27.529170      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 21:23:27.529464      13 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:23:27.529558      13 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0216 21:23:27.529438      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:23:27.529884      13 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:23:27.529898      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771277007\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771277007\" (2026-02-16 20:23:26 +0000 UTC to 2029-02-16 20:23:26 +0000 UTC (now=2026-02-16 21:23:27.529883867 +0000 UTC))"
I0216 21:23:27.530214      13 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 21:23:27.530745      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 21:23:27.530836      13 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0216 21:23:27.533000      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:23:27.538472      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:23:27.538904      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:23:27.561348      13 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0216 21:23:27.561834      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-vq0pa-ql6d8-pd6mq_0ca8e8ff-d2d7-47c7-bb0e-b2319f9010bb became leader"
I0216 21:23:27.569456      13 openstack.go:424] Setting up informers for Cloud
I0216 21:23:27.569515      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 21:23:27.569683      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 21:23:27.569697      13 controllermanager.go:310] Starting "service-lb-controller"
I0216 21:23:27.570263      13 openstack.go:373] Claiming to support LoadBalancer
I0216 21:23:27.570320      13 controllermanager.go:329] Started "service-lb-controller"
I0216 21:23:27.570326      13 controllermanager.go:310] Starting "node-route-controller"
I0216 21:23:27.570819      13 node_lifecycle_controller.go:112] Sending events to api server
I0216 21:23:27.571801      13 controller.go:234] Starting service controller
I0216 21:23:27.571874      13 shared_informer.go:350] "Waiting for caches to sync" controller="service"
I0216 21:23:27.630851      13 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0216 21:23:27.630908      13 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:23:27.630851      13 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:23:27.631777      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:16:39 +0000 UTC to 2031-02-15 21:16:39 +0000 UTC (now=2026-02-16 21:23:27.631586851 +0000 UTC))"
I0216 21:23:27.632641      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771277006\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771277006\" (2026-02-16 20:23:25 +0000 UTC to 2027-02-16 20:23:25 +0000 UTC (now=2026-02-16 21:23:27.632611359 +0000 UTC))"
I0216 21:23:27.633316      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771277007\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771277007\" (2026-02-16 20:23:26 +0000 UTC to 2029-02-16 20:23:26 +0000 UTC (now=2026-02-16 21:23:27.633285024 +0000 UTC))"
I0216 21:23:27.633490      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:16:39 +0000 UTC to 2031-02-15 21:16:39 +0000 UTC (now=2026-02-16 21:23:27.63346749 +0000 UTC))"
I0216 21:23:27.633533      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:16:45 +0000 UTC to 2031-02-15 21:16:45 +0000 UTC (now=2026-02-16 21:23:27.633518272 +0000 UTC))"
I0216 21:23:27.634460      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771277006\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771277006\" (2026-02-16 20:23:25 +0000 UTC to 2027-02-16 20:23:25 +0000 UTC (now=2026-02-16 21:23:27.634431426 +0000 UTC))"
I0216 21:23:27.635109      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771277007\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771277007\" (2026-02-16 20:23:26 +0000 UTC to 2029-02-16 20:23:26 +0000 UTC (now=2026-02-16 21:23:27.63508394 +0000 UTC))"
W0216 21:23:27.681193      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 21:23:27.681266      13 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 21:23:27.681278      13 controllermanager.go:317] Skipping "node-route-controller"
I0216 21:23:27.681289      13 controllermanager.go:310] Starting "cloud-node-controller"
I0216 21:23:27.681944      13 controllermanager.go:329] Started "cloud-node-controller"
I0216 21:23:27.682476      13 node_controller.go:176] Sending events to api server.
I0216 21:23:27.682720      13 node_controller.go:185] Waiting for informer caches to sync
I0216 21:23:27.690496      13 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:23:27.690715      13 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0216 21:23:27.772917      13 shared_informer.go:357] "Caches are synced" controller="service"
I0216 21:23:27.773268      13 controller.go:722] Syncing backends for all LB services.
I0216 21:23:27.773490      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:23:27.773791      13 controller.go:722] Syncing backends for all LB services.
I0216 21:23:27.773948      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:23:27.773998      13 controller.go:722] Syncing backends for all LB services.
I0216 21:23:27.774032      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:23:27.784358      13 node_controller.go:429] Initializing node kube-vq0pa-default-worker-xgjbd-8d7xf-8jvj8 with cloud provider
I0216 21:23:27.784817      13 node_controller.go:271] Update 3 nodes status took 689.406µs.
I0216 21:23:28.383448      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:23:28.383511      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:23:28.383519      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:23:28.383525      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:23:28.383531      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:23:28.383537      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:23:28.400087      13 controller.go:722] Syncing backends for all LB services.
I0216 21:23:28.400183      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:23:28.444869      13 node_controller.go:474] Successfully initialized node kube-vq0pa-default-worker-xgjbd-8d7xf-8jvj8 with cloud provider
I0216 21:23:28.445040      13 node_controller.go:429] Initializing node kube-vq0pa-default-worker-xgjbd-8d7xf-n5n7h with cloud provider
I0216 21:23:28.445734      13 event.go:389] "Event occurred" object="kube-vq0pa-default-worker-xgjbd-8d7xf-8jvj8" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:23:28.979690      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:23:28.979906      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:23:28.979953      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:23:28.979990      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:23:28.980025      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:23:28.980062      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:23:29.130850      13 controller.go:722] Syncing backends for all LB services.
I0216 21:23:29.130896      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:23:29.291676      13 node_controller.go:474] Successfully initialized node kube-vq0pa-default-worker-xgjbd-8d7xf-n5n7h with cloud provider
I0216 21:23:29.291788      13 node_controller.go:429] Initializing node kube-vq0pa-ql6d8-pd6mq with cloud provider
I0216 21:23:29.292295      13 event.go:389] "Event occurred" object="kube-vq0pa-default-worker-xgjbd-8d7xf-n5n7h" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:23:29.831474      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:23:29.831541      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:23:29.831554      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:23:29.831563      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:23:29.831576      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:23:29.831588      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:23:30.570353      13 controller.go:722] Syncing backends for all LB services.
I0216 21:23:30.570386      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:23:31.997802      13 node_controller.go:474] Successfully initialized node kube-vq0pa-ql6d8-pd6mq with cloud provider
I0216 21:23:32.040205      13 event.go:389] "Event occurred" object="kube-vq0pa-ql6d8-pd6mq" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:28:29.239951      13 node_controller.go:271] Update 3 nodes status took 1.454758514s.
I0216 21:33:30.274578      13 node_controller.go:271] Update 3 nodes status took 1.034187s.
I0216 21:38:31.587080      13 node_controller.go:271] Update 3 nodes status took 1.311060598s.
I0216 21:43:32.848720      13 node_controller.go:271] Update 3 nodes status took 1.261386022s.
I0216 21:44:58.474865      13 controller.go:722] Syncing backends for all LB services.
I0216 21:44:58.476620      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:44:58.544277      13 controller.go:722] Syncing backends for all LB services.
I0216 21:44:58.544323      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:48:34.079011      13 node_controller.go:271] Update 3 nodes status took 1.229296627s.
