2026/02/17 02:44:57 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=217a52b4-7d77-4b26-82cb-4a5d52c02878,--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:44:57 Now listening for interrupts
I0217 02:44:57.656175      12 serving.go:386] Generated self-signed cert in-memory
I0217 02:44:58.344435      12 serving.go:386] Generated self-signed cert in-memory
W0217 02:44:58.344545      12 client_config.go:682] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:44:58.725489      12 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:44:58.799994      12 controllermanager.go:160] Version: v1.35.0
I0217 02:44:58.810788      12 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:44:58.811273      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296297\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296297\" (2026-02-17 01:44:57 +0000 UTC to 2027-02-17 01:44:57 +0000 UTC (now=2026-02-17 02:44:58.811085543 +0000 UTC))"
I0217 02:44:58.811339      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:44:58.811581      12 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:44:58.811785      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296298\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296298\" (2026-02-17 01:44:58 +0000 UTC to 2029-02-17 01:44:58 +0000 UTC (now=2026-02-17 02:44:58.811704606 +0000 UTC))"
I0217 02:44:58.811962      12 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:44:58.812268      12 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:44:58.811313      12 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:44:58.812773      12 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:44:58.811868      12 shared_informer.go:370] "Waiting for caches to sync"
I0217 02:44:58.812735      12 leaderelection.go:258] "Attempting to acquire leader lease..." lock="kube-system/cloud-controller-manager"
I0217 02:44:58.825039      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:44:58.825510      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:44:58.826982      12 reflector.go:446] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:44:58.912080      12 shared_informer.go:377] "Caches are synced"
I0217 02:44:58.912613      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:48 +0000 UTC to 2031-02-16 02:36:48 +0000 UTC (now=2026-02-17 02:44:58.912578647 +0000 UTC))"
I0217 02:44:58.912993      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296297\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296297\" (2026-02-17 01:44:57 +0000 UTC to 2027-02-17 01:44:57 +0000 UTC (now=2026-02-17 02:44:58.912975865 +0000 UTC))"
I0217 02:44:58.913322      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296298\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296298\" (2026-02-17 01:44:58 +0000 UTC to 2029-02-17 01:44:58 +0000 UTC (now=2026-02-17 02:44:58.913308413 +0000 UTC))"
I0217 02:44:58.913405      12 shared_informer.go:377] "Caches are synced"
I0217 02:44:58.914144      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:42 +0000 UTC to 2031-02-16 02:36:42 +0000 UTC (now=2026-02-17 02:44:58.914099088 +0000 UTC))"
I0217 02:44:58.914252      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:48 +0000 UTC to 2031-02-16 02:36:48 +0000 UTC (now=2026-02-17 02:44:58.914242501 +0000 UTC))"
I0217 02:44:58.914758      12 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771296297\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771296297\" (2026-02-17 01:44:57 +0000 UTC to 2027-02-17 01:44:57 +0000 UTC (now=2026-02-17 02:44:58.914745531 +0000 UTC))"
I0217 02:44:58.915026      12 shared_informer.go:377] "Caches are synced"
I0217 02:44:58.915365      12 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771296298\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771296298\" (2026-02-17 01:44:58 +0000 UTC to 2029-02-17 01:44:58 +0000 UTC (now=2026-02-17 02:44:58.915352184 +0000 UTC))"
I0217 02:45:00.448720      12 leaderelection.go:272] "Successfully acquired lease" lock="kube-system/cloud-controller-manager"
I0217 02:45:00.451522      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-8hjc9-fqwd7-6lqfr_4f9bb944-c20e-4c9c-af02-803299875599 became leader"
I0217 02:45:00.452938      12 openstack.go:424] Setting up informers for Cloud
I0217 02:45:00.453008      12 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:45:00.479831      12 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:45:00.479866      12 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:45:00.481027      12 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:45:01.174996      12 openstack.go:373] Claiming to support LoadBalancer
I0217 02:45:01.175269      12 controllermanager.go:329] Started "service-lb-controller"
I0217 02:45:01.175318      12 controllermanager.go:310] Starting "node-route-controller"
I0217 02:45:01.175842      12 controller.go:235] Starting service controller
I0217 02:45:01.175907      12 shared_informer.go:370] "Waiting for caches to sync"
W0217 02:45:01.204395      12 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:45:01.204449      12 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:45:01.204460      12 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:45:01.204468      12 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:45:01.215462      12 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:45:01.215900      12 node_controller.go:176] Sending events to api server.
I0217 02:45:01.216084      12 node_controller.go:185] Waiting for informer caches to sync
I0217 02:45:01.231412      12 reflector.go:446] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:45:01.293666      12 reflector.go:446] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.35.0/tools/cache/reflector.go:289"
I0217 02:45:01.317437      12 node_controller.go:429] Initializing node kube-8hjc9-default-worker-pxndf-sp6tg-nvw9s with cloud provider
I0217 02:45:01.318781      12 node_controller.go:271] Update 3 nodes status took 214.165µs.
I0217 02:45:01.376824      12 shared_informer.go:377] "Caches are synced"
I0217 02:45:01.377534      12 controller.go:723] Syncing backends for all LB services.
I0217 02:45:01.377596      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:45:01.378055      12 controller.go:723] Syncing backends for all LB services.
I0217 02:45:01.378100      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:45:01.378113      12 controller.go:723] Syncing backends for all LB services.
I0217 02:45:01.378119      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:45:03.985639      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:45:03.985683      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:45:03.985688      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:45:03.985692      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:45:03.985697      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:45:03.985702      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:45:04.089907      12 controller.go:723] Syncing backends for all LB services.
I0217 02:45:04.090016      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:45:05.209668      12 node_controller.go:474] Successfully initialized node kube-8hjc9-default-worker-pxndf-sp6tg-nvw9s with cloud provider
I0217 02:45:05.210527      12 node_controller.go:429] Initializing node kube-8hjc9-fqwd7-6lqfr with cloud provider
I0217 02:45:05.211258      12 event.go:389] "Event occurred" object="kube-8hjc9-default-worker-pxndf-sp6tg-nvw9s" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:45:05.887408      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:45:05.887437      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:45:05.887446      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:45:05.887453      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:45:05.887462      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:45:05.887471      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:45:06.439995      12 controller.go:723] Syncing backends for all LB services.
I0217 02:45:06.443139      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:45:06.927692      12 node_controller.go:474] Successfully initialized node kube-8hjc9-fqwd7-6lqfr with cloud provider
I0217 02:45:06.927774      12 node_controller.go:429] Initializing node kube-8hjc9-default-worker-pxndf-sp6tg-8sjmt with cloud provider
I0217 02:45:06.929001      12 event.go:389] "Event occurred" object="kube-8hjc9-fqwd7-6lqfr" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:45:07.393303      12 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:45:07.393351      12 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:45:07.393359      12 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:45:07.393364      12 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:45:07.393370      12 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:45:07.393376      12 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:45:07.673866      12 controller.go:723] Syncing backends for all LB services.
I0217 02:45:07.673911      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:45:07.772066      12 node_controller.go:474] Successfully initialized node kube-8hjc9-default-worker-pxndf-sp6tg-8sjmt with cloud provider
I0217 02:45:07.773265      12 event.go:389] "Event occurred" object="kube-8hjc9-default-worker-pxndf-sp6tg-8sjmt" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:50:02.370969      12 node_controller.go:271] Update 3 nodes status took 1.050957005s.
I0217 02:55:03.470953      12 node_controller.go:271] Update 3 nodes status took 1.097742145s.
I0217 03:00:04.579136      12 node_controller.go:271] Update 3 nodes status took 1.106983329s.
I0217 03:00:57.894641      12 controller.go:723] Syncing backends for all LB services.
I0217 03:00:57.894729      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 03:00:58.011117      12 controller.go:723] Syncing backends for all LB services.
I0217 03:00:58.011168      12 controller.go:727] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 03:05:05.654022      12 node_controller.go:271] Update 3 nodes status took 1.073827229s.
I0217 03:10:06.766752      12 node_controller.go:271] Update 3 nodes status took 1.111116025s.
I0217 03:15:07.821655      12 node_controller.go:271] Update 3 nodes status took 1.053281811s.
