2026/02/16 21:15:10 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=2922746c-5398-4fde-9600-53630e54b675,--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:15:10 Now listening for interrupts
I0216 21:15:10.484025      12 serving.go:386] Generated self-signed cert in-memory
I0216 21:15:10.867288      12 serving.go:386] Generated self-signed cert in-memory
W0216 21:15:10.867340      12 client_config.go:682] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 21:15:11.187022      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 21:15:11.263210      12 controllermanager.go:160] Version: v1.35.0
I0216 21:15:11.269689      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 21:15:11.269850      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:11.270047      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 21:15:11.270690      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:11.270055      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 21:15:11.270702      12 shared_informer.go:370] "Waiting for caches to sync"
I0216 21:15:11.270313      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276510\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276510\" (2026-02-16 20:15:10 +0000 UTC to 2027-02-16 20:15:10 +0000 UTC (now=2026-02-16 21:15:11.270276985 +0000 UTC))"
I0216 21:15:11.272478      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276511\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276511\" (2026-02-16 20:15:10 +0000 UTC to 2029-02-16 20:15:10 +0000 UTC (now=2026-02-16 21:15:11.272464573 +0000 UTC))"
I0216 21:15:11.272624      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 21:15:11.273009      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 21:15:11.273939      12 leaderelection.go:258] "Attempting to acquire leader lease..." lock="kube-system/cloud-controller-manager"
I0216 21:15:11.274811      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:11.274981      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:11.275331      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:11.286763      12 leaderelection.go:272] "Successfully acquired lease" lock="kube-system/cloud-controller-manager"
I0216 21:15:11.287216      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-ey324-jsr8q-wzbgd_9e457b51-5f41-4527-8cc5-4f7153543b2d became leader"
I0216 21:15:11.289624      12 openstack.go:424] Setting up informers for Cloud
I0216 21:15:11.290035      12 controllermanager.go:310] Starting "cloud-node-controller"
I0216 21:15:11.300070      12 controllermanager.go:329] Started "cloud-node-controller"
I0216 21:15:11.300214      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 21:15:11.300818      12 node_controller.go:176] Sending events to api server.
I0216 21:15:11.300912      12 node_controller.go:185] Waiting for informer caches to sync
I0216 21:15:11.308638      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 21:15:11.308868      12 controllermanager.go:310] Starting "service-lb-controller"
I0216 21:15:11.308834      12 node_lifecycle_controller.go:112] Sending events to api server
I0216 21:15:11.371870      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:11.371975      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:11.372092      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:11.372323      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-15 21:10:17 +0000 UTC to 2031-02-15 21:10:17 +0000 UTC (now=2026-02-16 21:15:11.372296471 +0000 UTC))"
I0216 21:15:11.372895      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276510\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276510\" (2026-02-16 20:15:10 +0000 UTC to 2027-02-16 20:15:10 +0000 UTC (now=2026-02-16 21:15:11.37287402 +0000 UTC))"
I0216 21:15:11.373667      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276511\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276511\" (2026-02-16 20:15:10 +0000 UTC to 2029-02-16 20:15:10 +0000 UTC (now=2026-02-16 21:15:11.373226366 +0000 UTC))"
I0216 21:15:11.373953      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-15 21:10:16 +0000 UTC to 2031-02-15 21:10:16 +0000 UTC (now=2026-02-16 21:15:11.373934879 +0000 UTC))"
I0216 21:15:11.374031      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-15 21:10:17 +0000 UTC to 2031-02-15 21:10:17 +0000 UTC (now=2026-02-16 21:15:11.37401736 +0000 UTC))"
I0216 21:15:11.374358      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771276510\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771276510\" (2026-02-16 20:15:10 +0000 UTC to 2027-02-16 20:15:10 +0000 UTC (now=2026-02-16 21:15:11.374345276 +0000 UTC))"
I0216 21:15:11.374761      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771276511\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771276511\" (2026-02-16 20:15:10 +0000 UTC to 2029-02-16 20:15:10 +0000 UTC (now=2026-02-16 21:15:11.374744482 +0000 UTC))"
I0216 21:15:11.483343      12 openstack.go:373] Claiming to support LoadBalancer
I0216 21:15:11.483564      12 controllermanager.go:329] Started "service-lb-controller"
I0216 21:15:11.483584      12 controllermanager.go:310] Starting "node-route-controller"
I0216 21:15:11.483983      12 controller.go:235] Starting service controller
I0216 21:15:11.484191      12 shared_informer.go:370] "Waiting for caches to sync"
W0216 21:15:11.513225      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 21:15:11.513399      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 21:15:11.513413      12 controllermanager.go:317] Skipping "node-route-controller"
I0216 21:15:11.526304      12 reflector.go:446] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:11.526454      12 reflector.go:446] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0216 21:15:11.585188      12 shared_informer.go:377] "Caches are synced"
I0216 21:15:11.585326      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:11.585341      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:11.601982      12 node_controller.go:429] Initializing node kube-ey324-jsr8q-wzbgd with cloud provider
I0216 21:15:11.602135      12 node_controller.go:271] Update 1 nodes status took 212.894µs.
I0216 21:15:12.088428      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:12.088625      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:12.088672      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:12.088680      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:12.088687      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:12.088694      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:12.690932      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:12.690980      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:12.849714      12 node_controller.go:474] Successfully initialized node kube-ey324-jsr8q-wzbgd with cloud provider
I0216 21:15:12.850240      12 event.go:389] "Event occurred" object="kube-ey324-jsr8q-wzbgd" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:15:32.565505      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:32.565673      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:32.565764      12 node_controller.go:429] Initializing node kube-ey324-default-worker-czq9z-ds6nm-7nxqd with cloud provider
I0216 21:15:32.621851      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:32.621883      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:33.062409      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:33.062576      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:33.062651      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:33.062700      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:33.062746      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:33.062787      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:33.078160      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:33.078225      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:33.119503      12 node_controller.go:474] Successfully initialized node kube-ey324-default-worker-czq9z-ds6nm-7nxqd with cloud provider
I0216 21:15:33.120401      12 event.go:389] "Event occurred" object="kube-ey324-default-worker-czq9z-ds6nm-7nxqd" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:15:33.121956      12 node_controller.go:429] Initializing node kube-ey324-default-worker-czq9z-ds6nm-4b5v5 with cloud provider
I0216 21:15:33.537466      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 21:15:33.537514      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 21:15:33.537522      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 21:15:33.537527      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 21:15:33.537533      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 21:15:33.537539      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 21:15:33.552060      12 controller.go:723] Syncing backends for all LB services.
I0216 21:15:33.553148      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:15:33.582068      12 node_controller.go:474] Successfully initialized node kube-ey324-default-worker-czq9z-ds6nm-4b5v5 with cloud provider
I0216 21:15:33.582344      12 event.go:389] "Event occurred" object="kube-ey324-default-worker-czq9z-ds6nm-4b5v5" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 21:20:12.755729      12 node_controller.go:271] Update 3 nodes status took 1.153207613s.
I0216 21:25:13.747958      12 node_controller.go:271] Update 3 nodes status took 991.849303ms.
I0216 21:30:14.951737      12 node_controller.go:271] Update 3 nodes status took 1.202503887s.
I0216 21:34:20.065461      12 controller.go:723] Syncing backends for all LB services.
I0216 21:34:20.075517      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:34:20.161844      12 controller.go:723] Syncing backends for all LB services.
I0216 21:34:20.161879      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 21:35:15.878870      12 node_controller.go:271] Update 3 nodes status took 926.281932ms.
I0216 21:40:17.051451      12 node_controller.go:271] Update 3 nodes status took 1.172023092s.
