2026/02/16 19:46:16 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=555c4c15-6484-4a91-a7e7-83947ff72b1c,--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 19:46:16 Now listening for interrupts
I0216 19:46:16.484815      12 serving.go:386] Generated self-signed cert in-memory
I0216 19:46:16.620789      12 serving.go:386] Generated self-signed cert in-memory
W0216 19:46:16.621039      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0216 19:46:16.798613      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0216 19:46:16.862757      12 controllermanager.go:160] Version: v1.34.1
I0216 19:46:16.869808      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0216 19:46:16.869882      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0216 19:46:16.869945      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:46:16.869977      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:46:16.869983      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271176\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271176\" (2026-02-16 18:46:16 +0000 UTC to 2027-02-16 18:46:16 +0000 UTC (now=2026-02-16 19:46:16.86995071 +0000 UTC))"
I0216 19:46:16.870132      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:46:16.871626      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271176\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271176\" (2026-02-16 18:46:16 +0000 UTC to 2029-02-16 18:46:16 +0000 UTC (now=2026-02-16 19:46:16.871609418 +0000 UTC))"
I0216 19:46:16.871771      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0216 19:46:16.872100      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0216 19:46:16.871870      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:46:16.872484      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0216 19:46:16.876932      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 19:46:16.878423      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 19:46:16.879156      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 19:46:16.891573      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0216 19:46:16.892024      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-77bf4-jt7r5-2sh6l_ebbe9340-a1e6-4cbb-b79b-260e6b927912 became leader"
I0216 19:46:16.902441      12 openstack.go:424] Setting up informers for Cloud
I0216 19:46:16.902716      12 controllermanager.go:310] Starting "service-lb-controller"
I0216 19:46:16.970381      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0216 19:46:16.970880      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 19:41:54 +0000 UTC to 2031-02-15 19:41:54 +0000 UTC (now=2026-02-16 19:46:16.970854273 +0000 UTC))"
I0216 19:46:16.971159      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271176\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271176\" (2026-02-16 18:46:16 +0000 UTC to 2027-02-16 18:46:16 +0000 UTC (now=2026-02-16 19:46:16.971148193 +0000 UTC))"
I0216 19:46:16.971562      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271176\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271176\" (2026-02-16 18:46:16 +0000 UTC to 2029-02-16 18:46:16 +0000 UTC (now=2026-02-16 19:46:16.971548637 +0000 UTC))"
I0216 19:46:16.971626      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0216 19:46:16.973183      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0216 19:46:16.975873      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 19:41:54 +0000 UTC to 2031-02-15 19:41:54 +0000 UTC (now=2026-02-16 19:46:16.975296507 +0000 UTC))"
I0216 19:46:16.976755      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 19:41:55 +0000 UTC to 2031-02-15 19:41:55 +0000 UTC (now=2026-02-16 19:46:16.976615933 +0000 UTC))"
I0216 19:46:16.980202      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771271176\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771271176\" (2026-02-16 18:46:16 +0000 UTC to 2027-02-16 18:46:16 +0000 UTC (now=2026-02-16 19:46:16.980054383 +0000 UTC))"
I0216 19:46:16.987789      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771271176\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771271176\" (2026-02-16 18:46:16 +0000 UTC to 2029-02-16 18:46:16 +0000 UTC (now=2026-02-16 19:46:16.987776532 +0000 UTC))"
I0216 19:46:17.119817      12 openstack.go:373] Claiming to support LoadBalancer
I0216 19:46:17.120339      12 controllermanager.go:329] Started "service-lb-controller"
I0216 19:46:17.120604      12 controllermanager.go:310] Starting "node-route-controller"
I0216 19:46:17.121368      12 controller.go:235] Starting service controller
I0216 19:46:17.121716      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
W0216 19:46:17.144437      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0216 19:46:17.144480      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0216 19:46:17.144491      12 controllermanager.go:317] Skipping "node-route-controller"
I0216 19:46:17.144535      12 controllermanager.go:310] Starting "cloud-node-controller"
I0216 19:46:17.155420      12 controllermanager.go:329] Started "cloud-node-controller"
I0216 19:46:17.155487      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0216 19:46:17.155837      12 node_controller.go:176] Sending events to api server.
I0216 19:46:17.156590      12 node_controller.go:185] Waiting for informer caches to sync
I0216 19:46:17.164389      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0216 19:46:17.164678      12 node_lifecycle_controller.go:112] Sending events to api server
I0216 19:46:17.170853      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 19:46:17.171407      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0216 19:46:17.222969      12 shared_informer.go:356] "Caches are synced" controller="service"
I0216 19:46:17.223033      12 controller.go:723] Syncing backends for all LB services.
I0216 19:46:17.223043      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:46:17.257653      12 node_controller.go:429] Initializing node kube-77bf4-jt7r5-2sh6l with cloud provider
I0216 19:46:17.257945      12 node_controller.go:271] Update 1 nodes status took 160.015µs.
I0216 19:46:17.792821      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:46:17.793123      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:46:17.793205      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:46:17.793306      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:46:17.793356      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:46:17.793380      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:46:17.825337      12 controller.go:723] Syncing backends for all LB services.
I0216 19:46:17.825421      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:46:17.883178      12 node_controller.go:474] Successfully initialized node kube-77bf4-jt7r5-2sh6l with cloud provider
I0216 19:46:17.885197      12 event.go:389] "Event occurred" object="kube-77bf4-jt7r5-2sh6l" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:46:26.510129      12 controller.go:723] Syncing backends for all LB services.
I0216 19:46:26.510162      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:46:26.510185      12 node_controller.go:429] Initializing node kube-77bf4-default-worker-smkfj-6h28r-cdn8q with cloud provider
I0216 19:46:26.954411      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:46:26.954431      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:46:26.954437      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:46:26.954442      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:46:26.954448      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:46:26.954454      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:46:26.976397      12 controller.go:723] Syncing backends for all LB services.
I0216 19:46:26.976649      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:46:27.018054      12 node_controller.go:474] Successfully initialized node kube-77bf4-default-worker-smkfj-6h28r-cdn8q with cloud provider
I0216 19:46:27.018377      12 event.go:389] "Event occurred" object="kube-77bf4-default-worker-smkfj-6h28r-cdn8q" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:46:30.696899      12 node_controller.go:429] Initializing node kube-77bf4-default-worker-smkfj-6h28r-29h6z with cloud provider
I0216 19:46:30.703274      12 controller.go:723] Syncing backends for all LB services.
I0216 19:46:30.703348      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:46:31.330821      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0216 19:46:31.330956      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0216 19:46:31.330979      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0216 19:46:31.331002      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0216 19:46:31.331024      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0216 19:46:31.331047      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0216 19:46:31.701618      12 controller.go:723] Syncing backends for all LB services.
I0216 19:46:31.701641      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:46:31.766922      12 node_controller.go:474] Successfully initialized node kube-77bf4-default-worker-smkfj-6h28r-29h6z with cloud provider
I0216 19:46:31.768546      12 event.go:389] "Event occurred" object="kube-77bf4-default-worker-smkfj-6h28r-29h6z" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0216 19:48:06.151090      12 controller.go:723] Syncing backends for all LB services.
I0216 19:48:06.151149      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:48:06.213953      12 controller.go:723] Syncing backends for all LB services.
I0216 19:48:06.213997      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0216 19:51:18.273739      12 node_controller.go:271] Update 3 nodes status took 1.015393589s.
I0216 19:56:19.262777      12 node_controller.go:271] Update 3 nodes status took 988.766882ms.
I0216 20:01:20.246869      12 node_controller.go:271] Update 3 nodes status took 983.818198ms.
I0216 20:06:21.207411      12 node_controller.go:271] Update 3 nodes status took 959.67314ms.
I0216 20:11:22.116583      12 node_controller.go:271] Update 3 nodes status took 908.09048ms.
