2026/02/17 01:04:05 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=cf6120ed-fcf9-4b6d-9ac6-de61c2603439,--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 01:04:05 Now listening for interrupts
I0217 01:04:05.520694      12 serving.go:386] Generated self-signed cert in-memory
I0217 01:04:05.849226      12 serving.go:386] Generated self-signed cert in-memory
W0217 01:04:05.849305      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 01:04:06.001987      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 01:04:06.069267      12 controllermanager.go:160] Version: v1.32.1
I0217 01:04:06.074994      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771290245\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771290245\" (2026-02-17 00:04:05 +0000 UTC to 2027-02-17 00:04:05 +0000 UTC (now=2026-02-17 01:04:06.074955654 +0000 UTC))"
I0217 01:04:06.075551      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 01:04:06.075612      12 shared_informer.go:313] Waiting for caches to sync for RequestHeaderAuthRequestController
I0217 01:04:06.075872      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 01:04:06.075957      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 01:04:06.076304      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771290245\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771290245\" (2026-02-17 00:04:05 +0000 UTC to 2027-02-17 00:04:05 +0000 UTC (now=2026-02-17 01:04:06.075164698 +0000 UTC))"
I0217 01:04:06.076370      12 secure_serving.go:213] Serving securely on 127.0.0.1:10258
I0217 01:04:06.076677      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 01:04:06.077010      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 01:04:06.077798      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 01:04:06.077945      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 01:04:06.077977      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 01:04:06.080705      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 01:04:06.082294      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 01:04:06.104729      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 01:04:06.104787      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-9bo54-9mjrj-jp964_67f9966d-0c23-4a76-a16c-56d47330c04e became leader"
I0217 01:04:06.112255      12 openstack.go:424] Setting up informers for Cloud
I0217 01:04:06.112389      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 01:04:06.113166      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 01:04:06.113191      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 01:04:06.113418      12 node_controller.go:176] Sending events to api server.
I0217 01:04:06.113521      12 node_controller.go:185] Waiting for informer caches to sync
I0217 01:04:06.113831      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 01:04:06.113888      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 01:04:06.114179      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 01:04:06.114732      12 openstack.go:373] Claiming to support LoadBalancer
I0217 01:04:06.114762      12 controllermanager.go:329] Started "service-lb-controller"
I0217 01:04:06.114767      12 controllermanager.go:310] Starting "node-route-controller"
I0217 01:04:06.115135      12 controller.go:234] Starting service controller
I0217 01:04:06.115257      12 shared_informer.go:313] Waiting for caches to sync for service
W0217 01:04:06.158621      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 01:04:06.158676      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 01:04:06.158685      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 01:04:06.166204      12 reflector.go:376] Caches populated for *v1.Service from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 01:04:06.167660      12 reflector.go:376] Caches populated for *v1.Node from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 01:04:06.175739      12 shared_informer.go:320] Caches are synced for RequestHeaderAuthRequestController
I0217 01:04:06.176064      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 01:04:06.177938      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:58:52 +0000 UTC to 2031-02-16 00:58:52 +0000 UTC (now=2026-02-17 01:04:06.177915032 +0000 UTC))"
I0217 01:04:06.178486      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 01:04:06.179809      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771290245\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771290245\" (2026-02-17 00:04:05 +0000 UTC to 2027-02-17 00:04:05 +0000 UTC (now=2026-02-17 01:04:06.179792298 +0000 UTC))"
I0217 01:04:06.181393      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771290245\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771290245\" (2026-02-17 00:04:05 +0000 UTC to 2027-02-17 00:04:05 +0000 UTC (now=2026-02-17 01:04:06.181256616 +0000 UTC))"
I0217 01:04:06.181730      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:58:52 +0000 UTC to 2031-02-16 00:58:52 +0000 UTC (now=2026-02-17 01:04:06.181717695 +0000 UTC))"
I0217 01:04:06.181763      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:58:53 +0000 UTC to 2031-02-16 00:58:53 +0000 UTC (now=2026-02-17 01:04:06.181755646 +0000 UTC))"
I0217 01:04:06.190214      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771290245\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771290245\" (2026-02-17 00:04:05 +0000 UTC to 2027-02-17 00:04:05 +0000 UTC (now=2026-02-17 01:04:06.190191916 +0000 UTC))"
I0217 01:04:06.190666      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771290245\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771290245\" (2026-02-17 00:04:05 +0000 UTC to 2027-02-17 00:04:05 +0000 UTC (now=2026-02-17 01:04:06.190654425 +0000 UTC))"
I0217 01:04:06.213867      12 node_controller.go:429] Initializing node kube-9bo54-9mjrj-jp964 with cloud provider
I0217 01:04:06.214262      12 node_controller.go:271] Update 1 nodes status took 103.372µs.
I0217 01:04:06.219322      12 shared_informer.go:320] Caches are synced for service
I0217 01:04:06.219667      12 controller.go:722] Syncing backends for all LB services.
I0217 01:04:06.219688      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:04:06.715011      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 01:04:06.715039      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 01:04:06.715048      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 01:04:06.715058      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 01:04:06.715068      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 01:04:06.715078      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 01:04:06.764830      12 controller.go:722] Syncing backends for all LB services.
I0217 01:04:06.764880      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:04:06.850612      12 node_controller.go:474] Successfully initialized node kube-9bo54-9mjrj-jp964 with cloud provider
I0217 01:04:06.856786      12 event.go:389] "Event occurred" object="kube-9bo54-9mjrj-jp964" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 01:04:11.066737      12 controller.go:722] Syncing backends for all LB services.
I0217 01:04:11.066780      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:04:11.066811      12 node_controller.go:429] Initializing node kube-9bo54-default-worker-fjppm-nlswv-qvct5 with cloud provider
I0217 01:04:11.597371      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 01:04:11.597440      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 01:04:11.597455      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 01:04:11.597829      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 01:04:11.597875      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 01:04:11.597887      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 01:04:11.603231      12 controller.go:722] Syncing backends for all LB services.
I0217 01:04:11.603276      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:04:11.620094      12 controller.go:722] Syncing backends for all LB services.
I0217 01:04:11.620136      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:04:11.644730      12 node_controller.go:474] Successfully initialized node kube-9bo54-default-worker-fjppm-nlswv-qvct5 with cloud provider
I0217 01:04:11.644795      12 node_controller.go:429] Initializing node kube-9bo54-default-worker-fjppm-nlswv-m6bjw with cloud provider
I0217 01:04:11.645492      12 event.go:389] "Event occurred" object="kube-9bo54-default-worker-fjppm-nlswv-qvct5" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 01:04:11.975058      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 01:04:11.975149      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 01:04:11.975164      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 01:04:11.975177      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 01:04:11.975190      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 01:04:11.975204      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 01:04:11.994427      12 controller.go:722] Syncing backends for all LB services.
I0217 01:04:11.994460      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:04:12.046937      12 node_controller.go:474] Successfully initialized node kube-9bo54-default-worker-fjppm-nlswv-m6bjw with cloud provider
I0217 01:04:12.047350      12 event.go:389] "Event occurred" object="kube-9bo54-default-worker-fjppm-nlswv-m6bjw" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 01:09:07.631095      12 node_controller.go:271] Update 3 nodes status took 1.415610176s.
I0217 01:14:08.596957      12 node_controller.go:271] Update 3 nodes status took 965.506321ms.
I0217 01:19:09.469831      12 node_controller.go:271] Update 3 nodes status took 872.10345ms.
I0217 01:24:10.578144      12 node_controller.go:271] Update 3 nodes status took 1.108048327s.
I0217 01:25:01.807392      12 controller.go:722] Syncing backends for all LB services.
I0217 01:25:01.807433      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:25:01.892873      12 controller.go:722] Syncing backends for all LB services.
I0217 01:25:01.892920      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 01:29:11.633244      12 node_controller.go:271] Update 3 nodes status took 1.0549458s.
