2026/02/17 02:25:50 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=3e1dbb6f-a369-4838-a640-50ce91815c20,--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:25:50 Now listening for interrupts
I0217 02:25:51.248080      11 serving.go:386] Generated self-signed cert in-memory
I0217 02:25:51.823762      11 serving.go:386] Generated self-signed cert in-memory
W0217 02:25:51.823866      11 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:25:52.622834      11 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:25:52.670355      11 controllermanager.go:160] Version: v1.33.1
I0217 02:25:52.678325      11 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:25:52.678548      11 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:25:52.678608      11 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:25:52.678819      11 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:25:52.678775      11 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:25:52.678879      11 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:25:52.679502      11 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295151\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295150\" (2026-02-17 01:25:50 +0000 UTC to 2027-02-17 01:25:50 +0000 UTC (now=2026-02-17 02:25:52.679472124 +0000 UTC))"
I0217 02:25:52.680227      11 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295152\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295152\" (2026-02-17 01:25:51 +0000 UTC to 2029-02-17 01:25:51 +0000 UTC (now=2026-02-17 02:25:52.680207434 +0000 UTC))"
I0217 02:25:52.680433      11 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:25:52.680669      11 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:25:52.681499      11 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:25:52.681938      11 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:25:52.681997      11 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:25:52.682098      11 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:25:52.702730      11 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:25:52.703441      11 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-lfjkd-8ddgz-l4kqd_bdac4553-0790-4187-9a48-8c0608298361 became leader"
I0217 02:25:52.708871      11 openstack.go:424] Setting up informers for Cloud
I0217 02:25:52.708994      11 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:25:52.709755      11 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:25:52.709882      11 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:25:52.711210      11 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:25:52.711341      11 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:25:52.712496      11 openstack.go:373] Claiming to support LoadBalancer
I0217 02:25:52.712730      11 controllermanager.go:329] Started "service-lb-controller"
I0217 02:25:52.713474      11 controllermanager.go:310] Starting "node-route-controller"
I0217 02:25:52.714299      11 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:25:52.714315      11 node_controller.go:176] Sending events to api server.
I0217 02:25:52.715228      11 node_controller.go:185] Waiting for informer caches to sync
I0217 02:25:52.715477      11 controller.go:234] Starting service controller
I0217 02:25:52.715495      11 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0217 02:25:52.760284      11 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:25:52.760597      11 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:25:52.760920      11 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:25:52.768533      11 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:25:52.768873      11 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:25:52.779550      11 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:25:52.779787      11 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:25:52.779696      11 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:25:52.780984      11 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:20:42 +0000 UTC to 2031-02-16 02:20:42 +0000 UTC (now=2026-02-17 02:25:52.780960035 +0000 UTC))"
I0217 02:25:52.781264      11 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295151\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295150\" (2026-02-17 01:25:50 +0000 UTC to 2027-02-17 01:25:50 +0000 UTC (now=2026-02-17 02:25:52.781252919 +0000 UTC))"
I0217 02:25:52.781529      11 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295152\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295152\" (2026-02-17 01:25:51 +0000 UTC to 2029-02-17 01:25:51 +0000 UTC (now=2026-02-17 02:25:52.781517332 +0000 UTC))"
I0217 02:25:52.781599      11 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:20:42 +0000 UTC to 2031-02-16 02:20:42 +0000 UTC (now=2026-02-17 02:25:52.781591643 +0000 UTC))"
I0217 02:25:52.781620      11 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:20:44 +0000 UTC to 2031-02-16 02:20:44 +0000 UTC (now=2026-02-17 02:25:52.781613863 +0000 UTC))"
I0217 02:25:52.781808      11 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295151\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295150\" (2026-02-17 01:25:50 +0000 UTC to 2027-02-17 01:25:50 +0000 UTC (now=2026-02-17 02:25:52.781798666 +0000 UTC))"
I0217 02:25:52.782031      11 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295152\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295152\" (2026-02-17 01:25:51 +0000 UTC to 2029-02-17 01:25:51 +0000 UTC (now=2026-02-17 02:25:52.782021869 +0000 UTC))"
I0217 02:25:52.816851      11 node_controller.go:429] Initializing node kube-lfjkd-8ddgz-l4kqd with cloud provider
I0217 02:25:52.817570      11 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:25:52.817653      11 controller.go:722] Syncing backends for all LB services.
I0217 02:25:52.817669      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:25:52.817841      11 node_controller.go:271] Update 1 nodes status took 1.065923ms.
I0217 02:25:53.273020      11 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:25:53.273091      11 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:25:53.273101      11 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:25:53.273109      11 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:25:53.273117      11 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:25:53.273125      11 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:25:53.298978      11 controller.go:722] Syncing backends for all LB services.
I0217 02:25:53.299018      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:25:53.347047      11 node_controller.go:474] Successfully initialized node kube-lfjkd-8ddgz-l4kqd with cloud provider
I0217 02:25:53.348281      11 event.go:389] "Event occurred" object="kube-lfjkd-8ddgz-l4kqd" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:25:59.807753      11 controller.go:722] Syncing backends for all LB services.
I0217 02:25:59.807918      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:25:59.807978      11 controller.go:722] Syncing backends for all LB services.
I0217 02:25:59.808004      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:25:59.808077      11 node_controller.go:429] Initializing node kube-lfjkd-default-worker-dv6jz-dpv9b-nhmmz with cloud provider
I0217 02:26:00.329549      11 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:26:00.329572      11 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:26:00.329578      11 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:26:00.329583      11 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:26:00.329599      11 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:26:00.329605      11 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:26:00.350450      11 controller.go:722] Syncing backends for all LB services.
I0217 02:26:00.350499      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:26:00.385958      11 node_controller.go:474] Successfully initialized node kube-lfjkd-default-worker-dv6jz-dpv9b-nhmmz with cloud provider
I0217 02:26:00.386302      11 node_controller.go:429] Initializing node kube-lfjkd-default-worker-dv6jz-dpv9b-rs75h with cloud provider
I0217 02:26:00.386948      11 event.go:389] "Event occurred" object="kube-lfjkd-default-worker-dv6jz-dpv9b-nhmmz" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:26:01.025769      11 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:26:01.025824      11 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:26:01.025831      11 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:26:01.025837      11 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:26:01.025842      11 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:26:01.025848      11 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:26:01.040934      11 controller.go:722] Syncing backends for all LB services.
I0217 02:26:01.040979      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:26:01.056433      11 node_controller.go:474] Successfully initialized node kube-lfjkd-default-worker-dv6jz-dpv9b-rs75h with cloud provider
I0217 02:26:01.056531      11 event.go:389] "Event occurred" object="kube-lfjkd-default-worker-dv6jz-dpv9b-rs75h" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:30:53.999052      11 node_controller.go:271] Update 3 nodes status took 1.179976698s.
I0217 02:31:38.694614      11 controller.go:722] Syncing backends for all LB services.
I0217 02:31:38.700016      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:38.775384      11 controller.go:722] Syncing backends for all LB services.
I0217 02:31:38.775410      11 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:35:55.013082      11 node_controller.go:271] Update 3 nodes status took 1.01284109s.
I0217 02:40:56.158750      11 node_controller.go:271] Update 3 nodes status took 1.144871381s.
I0217 02:45:57.263958      11 node_controller.go:271] Update 3 nodes status took 1.104373603s.
I0217 02:50:58.520949      11 node_controller.go:271] Update 3 nodes status took 1.255472526s.
