2026/02/17 02:31:37 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=2f3c8a1e-00fe-47c2-bee2-03f5ae8c0be2,--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:37 Now listening for interrupts
I0217 02:31:37.366362      13 serving.go:386] Generated self-signed cert in-memory
I0217 02:31:37.781092      13 serving.go:386] Generated self-signed cert in-memory
W0217 02:31:37.781149      13 client_config.go:682] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:31:38.129134      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:31:38.188313      13 controllermanager.go:160] Version: v1.35.0
I0217 02:31:38.195139      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295497\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295497\" (2026-02-17 01:31:37 +0000 UTC to 2027-02-17 01:31:37 +0000 UTC (now=2026-02-17 02:31:38.195101585 +0000 UTC))"
I0217 02:31:38.195324      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295498\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295497\" (2026-02-17 01:31:37 +0000 UTC to 2029-02-17 01:31:37 +0000 UTC (now=2026-02-17 02:31:38.195314317 +0000 UTC))"
I0217 02:31:38.195396      13 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:31:38.195670      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:31:38.195929      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:38.195754      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:31:38.196478      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:38.195703      13 leaderelection.go:258] "Attempting to acquire leader lease..." lock="kube-system/cloud-controller-manager"
I0217 02:31:38.195763      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:31:38.199866      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:38.200267      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:31:38.200417      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:38.202194      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:38.202720      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:38.214617      13 leaderelection.go:272] "Successfully acquired lease" lock="kube-system/cloud-controller-manager"
I0217 02:31:38.215315      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-e17cw-vl7vr-pzpkv_b6b93615-04f2-4b9b-a733-b92df2172ffe became leader"
I0217 02:31:38.217872      13 openstack.go:424] Setting up informers for Cloud
I0217 02:31:38.217932      13 controllermanager.go:310] Starting "node-route-controller"
I0217 02:31:38.297081      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:38.297608      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:38.297886      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:27:23 +0000 UTC to 2031-02-16 02:27:23 +0000 UTC (now=2026-02-17 02:31:38.297868905 +0000 UTC))"
I0217 02:31:38.298501      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295497\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295497\" (2026-02-17 01:31:37 +0000 UTC to 2027-02-17 01:31:37 +0000 UTC (now=2026-02-17 02:31:38.298489692 +0000 UTC))"
I0217 02:31:38.298737      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295498\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295497\" (2026-02-17 01:31:37 +0000 UTC to 2029-02-17 01:31:37 +0000 UTC (now=2026-02-17 02:31:38.298728085 +0000 UTC))"
I0217 02:31:38.300836      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:38.301255      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:27:23 +0000 UTC to 2031-02-16 02:27:23 +0000 UTC (now=2026-02-17 02:31:38.301244835 +0000 UTC))"
I0217 02:31:38.301339      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:27:24 +0000 UTC to 2031-02-16 02:27:24 +0000 UTC (now=2026-02-17 02:31:38.301332346 +0000 UTC))"
I0217 02:31:38.301849      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295497\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295497\" (2026-02-17 01:31:37 +0000 UTC to 2027-02-17 01:31:37 +0000 UTC (now=2026-02-17 02:31:38.301792101 +0000 UTC))"
I0217 02:31:38.302296      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295498\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295497\" (2026-02-17 01:31:37 +0000 UTC to 2029-02-17 01:31:37 +0000 UTC (now=2026-02-17 02:31:38.302287407 +0000 UTC))"
W0217 02:31:38.320155      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:31:38.320198      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:38.320209      13 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:31:38.320217      13 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:31:38.329171      13 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:31:38.329236      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:31:38.329279      13 node_controller.go:176] Sending events to api server.
I0217 02:31:38.329371      13 node_controller.go:185] Waiting for informer caches to sync
I0217 02:31:38.341078      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:31:38.341140      13 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:31:38.341957      13 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:31:38.363791      13 openstack.go:373] Claiming to support LoadBalancer
I0217 02:31:38.363913      13 controllermanager.go:329] Started "service-lb-controller"
I0217 02:31:38.364257      13 controller.go:235] Starting service controller
I0217 02:31:38.364308      13 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:31:38.369823      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:38.373946      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:38.430288      13 node_controller.go:429] Initializing node kube-e17cw-vl7vr-pzpkv with cloud provider
I0217 02:31:38.430521      13 node_controller.go:271] Update 2 nodes status took 215.713µs.
I0217 02:31:38.464808      13 shared_informer.go:377] "Caches are synced"
I0217 02:31:38.465339      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:38.465583      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:38.465769      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:38.465949      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:38.937596      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:38.937654      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:38.937664      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:38.937673      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:38.937681      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:38.937970      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:38.955035      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:38.955080      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:39.022365      13 node_controller.go:474] Successfully initialized node kube-e17cw-vl7vr-pzpkv with cloud provider
I0217 02:31:39.022686      13 node_controller.go:429] Initializing node kube-e17cw-default-worker-7r88m-ncg6k-n7j7k with cloud provider
I0217 02:31:39.023222      13 event.go:389] "Event occurred" object="kube-e17cw-vl7vr-pzpkv" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:31:39.113009      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:39.113042      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:39.445623      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:39.445651      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:39.445658      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:39.445664      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:39.445671      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:39.445677      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:39.458408      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:39.458450      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:31:39.504827      13 node_controller.go:474] Successfully initialized node kube-e17cw-default-worker-7r88m-ncg6k-n7j7k with cloud provider
I0217 02:31:39.505546      13 node_controller.go:429] Initializing node kube-e17cw-default-worker-7r88m-ncg6k-8ckqv with cloud provider
I0217 02:31:39.506844      13 event.go:389] "Event occurred" object="kube-e17cw-default-worker-7r88m-ncg6k-n7j7k" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:31:39.903622      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:31:39.903647      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:31:39.903652      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:31:39.903656      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:31:39.903661      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:31:39.903665      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:31:39.959909      13 controller.go:723] Syncing backends for all LB services.
I0217 02:31:39.959936      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.060379      13 node_controller.go:474] Successfully initialized node kube-e17cw-default-worker-7r88m-ncg6k-8ckqv with cloud provider
I0217 02:31:40.062532      13 event.go:389] "Event occurred" object="kube-e17cw-default-worker-7r88m-ncg6k-8ckqv" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:39.647949      13 node_controller.go:271] Update 3 nodes status took 1.216373729s.
I0217 02:37:50.209076      13 controller.go:723] Syncing backends for all LB services.
I0217 02:37:50.210968      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:37:50.324213      13 controller.go:723] Syncing backends for all LB services.
I0217 02:37:50.328110      13 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:41:40.786134      13 node_controller.go:271] Update 3 nodes status took 1.137555675s.
I0217 02:46:41.793722      13 node_controller.go:271] Update 3 nodes status took 1.007295428s.
I0217 02:51:42.840690      13 node_controller.go:271] Update 3 nodes status took 1.046045012s.
I0217 02:56:43.777772      13 node_controller.go:271] Update 3 nodes status took 935.956988ms.
