2026/02/17 02:36:27 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=3433ead6-4e2c-40b6-9542-9419cb6e4eb8,--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:36:27 Now listening for interrupts
I0217 02:36:28.373206      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:36:28.893704      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:36:28.893742      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:36:29.347779      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:36:29.398022      12 controllermanager.go:160] Version: v1.32.1
I0217 02:36:29.407397      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:36:29.407621      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 02:36:29.407991      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:36:29.408301      12 shared_informer.go:313] Waiting for caches to sync for RequestHeaderAuthRequestController
I0217 02:36:29.408310      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295788\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295788\" (2026-02-17 01:36:27 +0000 UTC to 2027-02-17 01:36:27 +0000 UTC (now=2026-02-17 02:36:29.408202343 +0000 UTC))"
I0217 02:36:29.408602      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:36:29.409070      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295789\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295789\" (2026-02-17 01:36:28 +0000 UTC to 2027-02-17 01:36:28 +0000 UTC (now=2026-02-17 02:36:29.409054314 +0000 UTC))"
I0217 02:36:29.409190      12 secure_serving.go:213] Serving securely on 127.0.0.1:10258
I0217 02:36:29.409237      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 02:36:29.409591      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:36:29.410050      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:36:29.410993      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:36:29.411037      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:36:29.413509      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:36:29.426569      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:36:29.427044      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-qnue9-6m9bl-4rvxm_d1ca2be8-21b3-4c9f-9567-2961b28066f9 became leader"
I0217 02:36:29.431229      12 openstack.go:424] Setting up informers for Cloud
I0217 02:36:29.431271      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:36:29.432119      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:36:29.432144      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:36:29.432351      12 node_controller.go:176] Sending events to api server.
I0217 02:36:29.432644      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:36:29.433138      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:36:29.433147      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:36:29.433405      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:36:29.433995      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:36:29.434043      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:36:29.434049      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:36:29.434308      12 controller.go:234] Starting service controller
I0217 02:36:29.434350      12 shared_informer.go:313] Waiting for caches to sync for service
W0217 02:36:29.486686      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:36:29.486786      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:36:29.486797      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:36:29.493442      12 reflector.go:376] Caches populated for *v1.Service from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:36:29.495946      12 reflector.go:376] Caches populated for *v1.Node from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:36:29.509101      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 02:36:29.509126      12 shared_informer.go:320] Caches are synced for RequestHeaderAuthRequestController
I0217 02:36:29.509420      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 02:36:29.509852      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:31:28 +0000 UTC to 2031-02-16 02:31:28 +0000 UTC (now=2026-02-17 02:36:29.509825894 +0000 UTC))"
I0217 02:36:29.509976      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:31:30 +0000 UTC to 2031-02-16 02:31:30 +0000 UTC (now=2026-02-17 02:36:29.509964337 +0000 UTC))"
I0217 02:36:29.510385      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295788\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295788\" (2026-02-17 01:36:27 +0000 UTC to 2027-02-17 01:36:27 +0000 UTC (now=2026-02-17 02:36:29.510367822 +0000 UTC))"
I0217 02:36:29.510656      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295789\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295789\" (2026-02-17 01:36:28 +0000 UTC to 2027-02-17 01:36:28 +0000 UTC (now=2026-02-17 02:36:29.510575725 +0000 UTC))"
I0217 02:36:29.533023      12 node_controller.go:429] Initializing node kube-qnue9-6m9bl-4rvxm with cloud provider
I0217 02:36:29.534726      12 shared_informer.go:320] Caches are synced for service
I0217 02:36:29.534965      12 node_controller.go:271] Update 3 nodes status took 1.900956ms.
I0217 02:36:29.535074      12 controller.go:722] Syncing backends for all LB services.
I0217 02:36:29.535257      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:29.535344      12 controller.go:722] Syncing backends for all LB services.
I0217 02:36:29.535470      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:29.535560      12 controller.go:722] Syncing backends for all LB services.
I0217 02:36:29.535615      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:30.060302      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:36:30.060465      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:36:30.060496      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:36:30.060518      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:36:30.060540      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:36:30.060562      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:36:30.091561      12 controller.go:722] Syncing backends for all LB services.
I0217 02:36:30.091684      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:30.169389      12 node_controller.go:474] Successfully initialized node kube-qnue9-6m9bl-4rvxm with cloud provider
I0217 02:36:30.171518      12 event.go:389] "Event occurred" object="kube-qnue9-6m9bl-4rvxm" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:30.171898      12 node_controller.go:429] Initializing node kube-qnue9-default-worker-z645l-b5dp7-4qbvn with cloud provider
I0217 02:36:30.759202      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:36:30.759235      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:36:30.759240      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:36:30.759245      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:36:30.759249      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:36:30.759254      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:36:30.784982      12 controller.go:722] Syncing backends for all LB services.
I0217 02:36:30.785024      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:30.826852      12 node_controller.go:474] Successfully initialized node kube-qnue9-default-worker-z645l-b5dp7-4qbvn with cloud provider
I0217 02:36:30.826982      12 node_controller.go:429] Initializing node kube-qnue9-default-worker-z645l-b5dp7-ddm5n with cloud provider
I0217 02:36:30.827255      12 event.go:389] "Event occurred" object="kube-qnue9-default-worker-z645l-b5dp7-4qbvn" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:31.295107      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:36:31.295143      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:36:31.295200      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:36:31.295208      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:36:31.295214      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:36:31.295219      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:36:31.340078      12 controller.go:722] Syncing backends for all LB services.
I0217 02:36:31.340109      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:31.381066      12 node_controller.go:474] Successfully initialized node kube-qnue9-default-worker-z645l-b5dp7-ddm5n with cloud provider
I0217 02:36:31.381362      12 event.go:389] "Event occurred" object="kube-qnue9-default-worker-z645l-b5dp7-ddm5n" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:41:30.834904      12 node_controller.go:271] Update 3 nodes status took 1.299473387s.
I0217 02:46:31.874586      12 node_controller.go:271] Update 3 nodes status took 1.038711395s.
I0217 02:48:46.250847      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:46.250902      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:48:46.317231      12 controller.go:722] Syncing backends for all LB services.
I0217 02:48:46.317412      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:51:33.132848      12 node_controller.go:271] Update 3 nodes status took 1.257912039s.
I0217 02:56:34.234078      12 node_controller.go:271] Update 3 nodes status took 1.10038787s.
I0217 03:01:35.566183      12 node_controller.go:271] Update 3 nodes status took 1.331227464s.
