2026/02/17 02:42: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=ec41542f-e1fa-47fa-a1a1-0eef3d17bfcc,--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:42:50 Now listening for interrupts
I0217 02:42:51.779755      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:42:52.469380      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:42:52.469527      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:42:53.647864      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:42:53.717168      12 controllermanager.go:160] Version: v1.32.1
I0217 02:42:54.600581      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296171\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296171\" (2026-02-17 01:42:50 +0000 UTC to 2027-02-17 01:42:50 +0000 UTC (now=2026-02-17 02:42:54.600464076 +0000 UTC))"
I0217 02:42:54.600839      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296172\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296172\" (2026-02-17 01:42:52 +0000 UTC to 2027-02-17 01:42:52 +0000 UTC (now=2026-02-17 02:42:54.600814546 +0000 UTC))"
I0217 02:42:54.600907      12 secure_serving.go:213] Serving securely on 127.0.0.1:10258
I0217 02:42:54.602459      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:42:54.603101      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:42:54.603144      12 shared_informer.go:313] Waiting for caches to sync for RequestHeaderAuthRequestController
I0217 02:42:54.603198      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:42:54.603408      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:42:54.603423      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 02:42:54.603446      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:42:54.603455      12 shared_informer.go:313] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 02:42:54.609559      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:42:54.609937      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:42:54.610182      12 reflector.go:376] Caches populated for *v1.ConfigMap from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:42:54.650852      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:42:54.651078      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-vj3kx-fkmwx-hxjcj_69cfe412-1d6a-45dd-8917-34bc33362e4d became leader"
I0217 02:42:54.657407      12 openstack.go:424] Setting up informers for Cloud
I0217 02:42:54.657499      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:42:54.657933      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:42:54.657963      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:42:54.658465      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:42:54.659368      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:42:54.659945      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:42:54.659972      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:42:54.660562      12 controller.go:234] Starting service controller
I0217 02:42:54.660584      12 shared_informer.go:313] Waiting for caches to sync for service
I0217 02:42:54.703751      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file
I0217 02:42:54.704128      12 shared_informer.go:320] Caches are synced for RequestHeaderAuthRequestController
I0217 02:42:54.704455      12 shared_informer.go:320] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0217 02:42:54.704784      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-16 02:36:08 +0000 UTC to 2031-02-16 02:36:08 +0000 UTC (now=2026-02-17 02:42:54.704760463 +0000 UTC))"
I0217 02:42:54.705367      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296171\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296171\" (2026-02-17 01:42:50 +0000 UTC to 2027-02-17 01:42:50 +0000 UTC (now=2026-02-17 02:42:54.705352694 +0000 UTC))"
I0217 02:42:54.705684      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296172\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296172\" (2026-02-17 01:42:52 +0000 UTC to 2027-02-17 01:42:52 +0000 UTC (now=2026-02-17 02:42:54.705669435 +0000 UTC))"
I0217 02:42:54.705799      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-16 02:36:05 +0000 UTC to 2031-02-16 02:36:05 +0000 UTC (now=2026-02-17 02:42:54.705787695 +0000 UTC))"
I0217 02:42:54.706531      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-16 02:36:08 +0000 UTC to 2031-02-16 02:36:08 +0000 UTC (now=2026-02-17 02:42:54.706516816 +0000 UTC))"
I0217 02:42:54.706796      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296171\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296171\" (2026-02-17 01:42:50 +0000 UTC to 2027-02-17 01:42:50 +0000 UTC (now=2026-02-17 02:42:54.706783387 +0000 UTC))"
I0217 02:42:54.707834      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296172\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296172\" (2026-02-17 01:42:52 +0000 UTC to 2027-02-17 01:42:52 +0000 UTC (now=2026-02-17 02:42:54.706976087 +0000 UTC))"
W0217 02:42:54.738220      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:42:54.738256      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:42:54.738268      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:42:54.738322      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:42:54.739162      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:42:54.739765      12 node_controller.go:176] Sending events to api server.
I0217 02:42:54.741438      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:42:54.753960      12 reflector.go:376] Caches populated for *v1.Node from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:42:54.755138      12 reflector.go:376] Caches populated for *v1.Service from k8s.io/client-go@v0.32.7/tools/cache/reflector.go:251
I0217 02:42:54.761148      12 shared_informer.go:320] Caches are synced for service
I0217 02:42:54.761231      12 controller.go:722] Syncing backends for all LB services.
I0217 02:42:54.761377      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:42:54.761410      12 controller.go:722] Syncing backends for all LB services.
I0217 02:42:54.761428      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:42:54.761477      12 controller.go:722] Syncing backends for all LB services.
I0217 02:42:54.761494      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:42:54.853709      12 node_controller.go:429] Initializing node kube-vj3kx-default-worker-nlsqr-qhh5m-fbjc6 with cloud provider
I0217 02:42:54.854230      12 node_controller.go:271] Update 3 nodes status took 10.604619ms.
I0217 02:42:56.669312      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:42:56.669361      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:42:56.669370      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:42:56.669377      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:42:56.669385      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:42:56.669393      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:42:56.865888      12 controller.go:722] Syncing backends for all LB services.
I0217 02:42:56.866089      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:42:58.476896      12 node_controller.go:474] Successfully initialized node kube-vj3kx-default-worker-nlsqr-qhh5m-fbjc6 with cloud provider
I0217 02:42:58.476980      12 node_controller.go:429] Initializing node kube-vj3kx-default-worker-nlsqr-qhh5m-g8qlt with cloud provider
I0217 02:42:58.477571      12 event.go:389] "Event occurred" object="kube-vj3kx-default-worker-nlsqr-qhh5m-fbjc6" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:42:58.823633      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:42:58.823730      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:42:58.823749      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:42:58.823764      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:42:58.823781      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:42:58.823799      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:42:59.368621      12 controller.go:722] Syncing backends for all LB services.
I0217 02:42:59.369009      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:42:59.453954      12 node_controller.go:474] Successfully initialized node kube-vj3kx-default-worker-nlsqr-qhh5m-g8qlt with cloud provider
I0217 02:42:59.454014      12 node_controller.go:429] Initializing node kube-vj3kx-fkmwx-hxjcj with cloud provider
I0217 02:42:59.454591      12 event.go:389] "Event occurred" object="kube-vj3kx-default-worker-nlsqr-qhh5m-g8qlt" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:43:00.122018      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:43:00.122322      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:43:00.122431      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:43:00.122460      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:43:00.122627      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:43:00.122789      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:43:00.151306      12 controller.go:722] Syncing backends for all LB services.
I0217 02:43:00.151363      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:43:00.366179      12 node_controller.go:474] Successfully initialized node kube-vj3kx-fkmwx-hxjcj with cloud provider
I0217 02:43:00.366668      12 event.go:389] "Event occurred" object="kube-vj3kx-fkmwx-hxjcj" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:47:56.120056      12 node_controller.go:271] Update 3 nodes status took 1.264554889s.
I0217 02:52:57.376105      12 node_controller.go:271] Update 3 nodes status took 1.249137498s.
I0217 02:57:58.695108      12 node_controller.go:271] Update 3 nodes status took 1.318560413s.
I0217 03:01:50.782911      12 controller.go:722] Syncing backends for all LB services.
I0217 03:01:50.783030      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 03:01:50.876033      12 controller.go:722] Syncing backends for all LB services.
I0217 03:01:50.876102      12 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 03:02:59.834766      12 node_controller.go:271] Update 3 nodes status took 1.138432578s.
I0217 03:08:01.083116      12 node_controller.go:271] Update 3 nodes status took 1.247235544s.
