2026/02/17 02:31:13 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=8391ea03-ecaf-48f5-aca8-26713757bc6d,--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:31:13 Now listening for interrupts
I0217 02:31:14.144354      13 serving.go:386] Generated self-signed cert in-memory
I0217 02:31:14.444898      13 serving.go:386] Generated self-signed cert in-memory
W0217 02:31:14.444942      13 client_config.go:682] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:31:14.619680      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:31:14.672166      13 controllermanager.go:160] Version: v1.35.0
I0217 02:31:14.687753      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:31:14.687808      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:14.687809      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:31:14.687983      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:14.688385      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:31:14.688533      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:14.689341      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295474\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295474\" (2026-02-17 01:31:13 +0000 UTC to 2027-02-17 01:31:13 +0000 UTC (now=2026-02-17 02:31:14.689312637 +0000 UTC))"
I0217 02:31:14.689902      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295474\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295474\" (2026-02-17 01:31:14 +0000 UTC to 2029-02-17 01:31:14 +0000 UTC (now=2026-02-17 02:31:14.689888155 +0000 UTC))"
I0217 02:31:14.690991      13 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:31:14.692923      13 leaderelection.go:258] "Attempting to acquire leader lease..." lock="kube-system/cloud-controller-manager"
I0217 02:31:14.691471      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:31:14.695479      13 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:31:14.695635      13 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:31:14.696271      13 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:31:14.708589      13 leaderelection.go:272] "Successfully acquired lease" lock="kube-system/cloud-controller-manager"
I0217 02:31:14.708918      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-iif1s-gsf9h-kgd22_1349ef80-a401-42fd-bae9-20d2ed2fd582 became leader"
I0217 02:31:14.718506      13 openstack.go:424] Setting up informers for Cloud
I0217 02:31:14.718739      13 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:31:14.734692      13 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:31:14.734905      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:31:14.734784      13 node_controller.go:176] Sending events to api server.
I0217 02:31:14.735503      13 node_controller.go:185] Waiting for informer caches to sync
I0217 02:31:14.750741      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:31:14.750784      13 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:31:14.751210      13 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:31:14.788181      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:14.788428      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:14.789123      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-16 02:26:22 +0000 UTC to 2031-02-16 02:26:22 +0000 UTC (now=2026-02-17 02:31:14.788955033 +0000 UTC))"
I0217 02:31:14.789853      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295474\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295474\" (2026-02-17 01:31:13 +0000 UTC to 2027-02-17 01:31:13 +0000 UTC (now=2026-02-17 02:31:14.789832434 +0000 UTC))"
I0217 02:31:14.790115      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:14.791830      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295474\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295474\" (2026-02-17 01:31:14 +0000 UTC to 2029-02-17 01:31:14 +0000 UTC (now=2026-02-17 02:31:14.791783909 +0000 UTC))"
I0217 02:31:14.792044      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-16 02:26:21 +0000 UTC to 2031-02-16 02:26:21 +0000 UTC (now=2026-02-17 02:31:14.792016418 +0000 UTC))"
I0217 02:31:14.792433      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-16 02:26:22 +0000 UTC to 2031-02-16 02:26:22 +0000 UTC (now=2026-02-17 02:31:14.792117439 +0000 UTC))"
I0217 02:31:14.798761      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295474\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295474\" (2026-02-17 01:31:13 +0000 UTC to 2027-02-17 01:31:13 +0000 UTC (now=2026-02-17 02:31:14.798735105 +0000 UTC))"
I0217 02:31:14.799530      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295474\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295474\" (2026-02-17 01:31:14 +0000 UTC to 2029-02-17 01:31:14 +0000 UTC (now=2026-02-17 02:31:14.799507505 +0000 UTC))"
I0217 02:31:14.933689      13 openstack.go:373] Claiming to support LoadBalancer
I0217 02:31:14.933811      13 controllermanager.go:329] Started "service-lb-controller"
I0217 02:31:14.933825      13 controllermanager.go:310] Starting "node-route-controller"
I0217 02:31:14.934493      13 controller.go:235] Starting service controller
I0217 02:31:14.934533      13 shared_informer.go:370] "Waiting for caches to sync"
W0217 02:31:14.968626      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:31:14.968662      13 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:31:14.968674      13 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:31:14.976921      13 reflector.go:446] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:31:14.977142      13 reflector.go:446] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:31:15.035259      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:15.035332      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:15.035399      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:15.036801      13 node_controller.go:429] Initializing node kube-iif1s-gsf9h-kgd22 with cloud provider
I0217 02:31:15.037537      13 node_controller.go:271] Update 1 nodes status took 81.733µs.
I0217 02:31:15.676016      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:15.676060      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:15.676067      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:15.676072      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:15.676078      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:15.676085      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:15.817305      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:15.817339      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:16.291156      13 node_controller.go:474] Successfully initialized node kube-iif1s-gsf9h-kgd22 with cloud provider
I0217 02:31:16.291698      13 event.go:389] "Event occurred" object="kube-iif1s-gsf9h-kgd22" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:31:40.192559      13 node_controller.go:429] Initializing node kube-iif1s-default-worker-tvdl4-vjmmf-9tr6c with cloud provider
I0217 02:31:40.192761      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:40.192800      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:40.635455      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:40.635563      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:40.635575      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:40.635584      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:40.635595      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:40.635638      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:40.795656      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:40.795703      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:40.987379      13 node_controller.go:474] Successfully initialized node kube-iif1s-default-worker-tvdl4-vjmmf-9tr6c with cloud provider
I0217 02:31:40.987863      13 event.go:389] "Event occurred" object="kube-iif1s-default-worker-tvdl4-vjmmf-9tr6c" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:31:42.160173      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:42.160215      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:42.160247      13 node_controller.go:429] Initializing node kube-iif1s-default-worker-tvdl4-vjmmf-sd9n7 with cloud provider
I0217 02:31:42.579003      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:42.579068      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:42.579079      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:42.579088      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:42.579097      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:42.579106      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:42.592036      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:42.592081      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:42.602641      13 node_controller.go:474] Successfully initialized node kube-iif1s-default-worker-tvdl4-vjmmf-sd9n7 with cloud provider
I0217 02:31:42.603050      13 event.go:389] "Event occurred" object="kube-iif1s-default-worker-tvdl4-vjmmf-sd9n7" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:16.181779      13 node_controller.go:271] Update 3 nodes status took 1.14323865s.
I0217 02:41:17.125176      13 node_controller.go:271] Update 3 nodes status took 942.72194ms.
I0217 02:46:18.406371      13 node_controller.go:271] Update 3 nodes status took 1.280067612s.
I0217 02:51:19.400468      13 node_controller.go:271] Update 3 nodes status took 993.072906ms.
I0217 02:54:04.588626      13 controller.go:723] Syncing backends for all LB services.
I0217 02:54:04.588675      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:54:04.678200      13 controller.go:723] Syncing backends for all LB services.
I0217 02:54:04.678245      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:56:20.901097      13 node_controller.go:271] Update 3 nodes status took 1.500124382s.
