2026/02/17 02:38:34 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=00f2e8f1-0a34-4e7d-9f11-02cf0c702559,--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:38:34 Now listening for interrupts
I0217 02:38:34.391086      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:38:34.639884      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:38:34.639949      12 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:38:35.084570      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:38:35.139035      12 controllermanager.go:160] Version: v1.34.1
I0217 02:38:35.148582      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:38:35.148947      12 shared_informer.go:349] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:38:35.149048      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:38:35.149076      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:38:35.149225      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:38:35.149297      12 shared_informer.go:349] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:38:35.149488      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295914\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295914\" (2026-02-17 01:38:34 +0000 UTC to 2027-02-17 01:38:34 +0000 UTC (now=2026-02-17 02:38:35.149389031 +0000 UTC))"
I0217 02:38:35.150761      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295915\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295914\" (2026-02-17 01:38:34 +0000 UTC to 2029-02-17 01:38:34 +0000 UTC (now=2026-02-17 02:38:35.150745732 +0000 UTC))"
I0217 02:38:35.150846      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:38:35.150940      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:38:35.151461      12 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:38:35.155011      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:38:35.155209      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:38:35.157237      12 reflector.go:436] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:38:35.249923      12 shared_informer.go:356] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:38:35.250153      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:38:35.250610      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:31:19 +0000 UTC to 2031-02-16 02:31:19 +0000 UTC (now=2026-02-17 02:38:35.250538288 +0000 UTC))"
I0217 02:38:35.251003      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295914\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295914\" (2026-02-17 01:38:34 +0000 UTC to 2027-02-17 01:38:34 +0000 UTC (now=2026-02-17 02:38:35.250987054 +0000 UTC))"
I0217 02:38:35.251274      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295915\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295914\" (2026-02-17 01:38:34 +0000 UTC to 2029-02-17 01:38:34 +0000 UTC (now=2026-02-17 02:38:35.251258391 +0000 UTC))"
I0217 02:38:35.254858      12 shared_informer.go:356] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:38:35.256566      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:31:19 +0000 UTC to 2031-02-16 02:31:19 +0000 UTC (now=2026-02-17 02:38:35.256502893 +0000 UTC))"
I0217 02:38:35.256830      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:31:25 +0000 UTC to 2031-02-16 02:31:25 +0000 UTC (now=2026-02-17 02:38:35.256814132 +0000 UTC))"
I0217 02:38:35.257203      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295914\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295914\" (2026-02-17 01:38:34 +0000 UTC to 2027-02-17 01:38:34 +0000 UTC (now=2026-02-17 02:38:35.257188195 +0000 UTC))"
I0217 02:38:35.257594      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295915\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295914\" (2026-02-17 01:38:34 +0000 UTC to 2029-02-17 01:38:34 +0000 UTC (now=2026-02-17 02:38:35.257573057 +0000 UTC))"
I0217 02:38:35.290162      12 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:38:35.291991      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-vjvm3-xqqzl-fdszz_5fbf194c-578d-42fc-8cfe-4a2083899f85 became leader"
I0217 02:38:35.295889      12 openstack.go:424] Setting up informers for Cloud
I0217 02:38:35.295958      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:38:35.317380      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:38:35.317832      12 node_controller.go:176] Sending events to api server.
I0217 02:38:35.318212      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:38:35.317846      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:38:35.332740      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:38:35.332787      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:38:35.333411      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:38:35.554312      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:38:35.554539      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:38:35.554557      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:38:35.555269      12 controller.go:235] Starting service controller
I0217 02:38:35.555303      12 shared_informer.go:349] "Waiting for caches to sync" controller="service"
W0217 02:38:35.595537      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:38:35.595834      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:38:35.595898      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:38:35.674140      12 reflector.go:436] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:38:35.674612      12 reflector.go:436] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.34.1/tools/cache/reflector.go:290"
I0217 02:38:35.719374      12 node_controller.go:429] Initializing node kube-vjvm3-default-worker-hq7h7-st4sl-z9wp6 with cloud provider
I0217 02:38:35.730760      12 node_controller.go:271] Update 3 nodes status took 11.302355ms.
I0217 02:38:35.756957      12 shared_informer.go:356] "Caches are synced" controller="service"
I0217 02:38:35.758358      12 controller.go:723] Syncing backends for all LB services.
I0217 02:38:35.758483      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:35.759072      12 controller.go:723] Syncing backends for all LB services.
I0217 02:38:35.759172      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:35.759184      12 controller.go:723] Syncing backends for all LB services.
I0217 02:38:35.759255      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:36.447041      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:38:36.447068      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:38:36.447075      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:38:36.447080      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:38:36.447087      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:38:36.447094      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:38:38.171106      12 controller.go:723] Syncing backends for all LB services.
I0217 02:38:38.171148      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:42.804235      12 node_controller.go:474] Successfully initialized node kube-vjvm3-default-worker-hq7h7-st4sl-z9wp6 with cloud provider
I0217 02:38:42.804347      12 node_controller.go:429] Initializing node kube-vjvm3-default-worker-hq7h7-st4sl-znfpt with cloud provider
I0217 02:38:42.804783      12 event.go:389] "Event occurred" object="kube-vjvm3-default-worker-hq7h7-st4sl-z9wp6" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:38:43.365362      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:38:43.365775      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:38:43.366409      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:38:43.366568      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:38:43.366717      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:38:43.366797      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:38:43.600437      12 controller.go:723] Syncing backends for all LB services.
I0217 02:38:43.600463      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:43.927863      12 node_controller.go:474] Successfully initialized node kube-vjvm3-default-worker-hq7h7-st4sl-znfpt with cloud provider
I0217 02:38:43.928021      12 node_controller.go:429] Initializing node kube-vjvm3-xqqzl-fdszz with cloud provider
I0217 02:38:43.931883      12 event.go:389] "Event occurred" object="kube-vjvm3-default-worker-hq7h7-st4sl-znfpt" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:38:44.402341      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:38:44.402381      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:38:44.402387      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:38:44.402391      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:38:44.402396      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:38:44.402401      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:38:44.432602      12 controller.go:723] Syncing backends for all LB services.
I0217 02:38:44.432657      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:38:45.237518      12 node_controller.go:474] Successfully initialized node kube-vjvm3-xqqzl-fdszz with cloud provider
I0217 02:38:45.237973      12 event.go:389] "Event occurred" object="kube-vjvm3-xqqzl-fdszz" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:43:37.396698      12 node_controller.go:271] Update 3 nodes status took 1.665287712s.
I0217 02:48:38.669825      12 node_controller.go:271] Update 3 nodes status took 1.271981026s.
I0217 02:53:39.787463      12 node_controller.go:271] Update 3 nodes status took 1.116833624s.
I0217 02:56:38.128568      12 controller.go:723] Syncing backends for all LB services.
I0217 02:56:38.128765      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:56:38.292916      12 controller.go:723] Syncing backends for all LB services.
I0217 02:56:38.296993      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:58:41.025481      12 node_controller.go:271] Update 3 nodes status took 1.236980473s.
I0217 03:03:42.199927      12 node_controller.go:271] Update 3 nodes status took 1.173236955s.
