2026/02/17 02:36:28 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=c26e2070-a935-401f-bf17-b300d49eced5,--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:36:28 Now listening for interrupts
I0217 02:36:30.274701      13 serving.go:386] Generated self-signed cert in-memory
I0217 02:36:31.149717      13 serving.go:386] Generated self-signed cert in-memory
W0217 02:36:31.149855      13 client_config.go:667] Neither --kubeconfig nor --master was specified.  Using the inClusterConfig.  This might not work.
I0217 02:36:32.016217      13 requestheader_controller.go:255] Loaded a new request header values for RequestHeaderAuthRequestController
I0217 02:36:32.066434      13 controllermanager.go:160] Version: v1.33.1
I0217 02:36:32.078532      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295790\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295789\" (2026-02-17 01:36:28 +0000 UTC to 2027-02-17 01:36:28 +0000 UTC (now=2026-02-17 02:36:32.078498452 +0000 UTC))"
I0217 02:36:32.078592      13 requestheader_controller.go:180] Starting RequestHeaderAuthRequestController
I0217 02:36:32.078630      13 shared_informer.go:350] "Waiting for caches to sync" controller="RequestHeaderAuthRequestController"
I0217 02:36:32.078761      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:36:32.078775      13 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:36:32.078821      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295792\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295791\" (2026-02-17 01:36:31 +0000 UTC to 2029-02-17 01:36:31 +0000 UTC (now=2026-02-17 02:36:32.078806288 +0000 UTC))"
I0217 02:36:32.078941      13 secure_serving.go:211] Serving securely on 127.0.0.1:10258
I0217 02:36:32.079575      13 leaderelection.go:257] attempting to acquire leader lease kube-system/cloud-controller-manager...
I0217 02:36:32.079635      13 tlsconfig.go:243] "Starting DynamicServingCertificateController"
I0217 02:36:32.078855      13 configmap_cafile_content.go:205] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:36:32.079713      13 shared_informer.go:350] "Waiting for caches to sync" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:36:32.082817      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:36:32.083107      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:36:32.085055      13 reflector.go:430] "Caches populated" type="*v1.ConfigMap" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:36:32.103352      13 leaderelection.go:271] successfully acquired lease kube-system/cloud-controller-manager
I0217 02:36:32.103564      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-m89c8-mpmpl-wt7wn_cc123ab6-e3f8-41f2-8514-8662fb17a1e1 became leader"
I0217 02:36:32.110581      13 openstack.go:424] Setting up informers for Cloud
I0217 02:36:32.110822      13 controllermanager.go:310] Starting "cloud-node-controller"
I0217 02:36:32.113642      13 controllermanager.go:329] Started "cloud-node-controller"
I0217 02:36:32.113810      13 controllermanager.go:310] Starting "cloud-node-lifecycle-controller"
I0217 02:36:32.113690      13 node_controller.go:176] Sending events to api server.
I0217 02:36:32.114103      13 node_controller.go:185] Waiting for informer caches to sync
I0217 02:36:32.114824      13 controllermanager.go:329] Started "cloud-node-lifecycle-controller"
I0217 02:36:32.115018      13 controllermanager.go:310] Starting "service-lb-controller"
I0217 02:36:32.114936      13 node_lifecycle_controller.go:112] Sending events to api server
I0217 02:36:32.116873      13 openstack.go:373] Claiming to support LoadBalancer
I0217 02:36:32.117081      13 controllermanager.go:329] Started "service-lb-controller"
I0217 02:36:32.117170      13 controllermanager.go:310] Starting "node-route-controller"
I0217 02:36:32.117380      13 controller.go:234] Starting service controller
I0217 02:36:32.117429      13 shared_informer.go:350] "Waiting for caches to sync" controller="service"
W0217 02:36:32.164460      13 openstack.go:408] Error initialising Routes support: router-id not set in cloud provider config
W0217 02:36:32.164509      13 core.go:111] --configure-cloud-routes is set, but cloud provider does not support routes. Will not configure cloud provider routes.
W0217 02:36:32.164517      13 controllermanager.go:317] Skipping "node-route-controller"
I0217 02:36:32.174477      13 reflector.go:430] "Caches populated" type="*v1.Service" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:36:32.176892      13 reflector.go:430] "Caches populated" type="*v1.Node" reflector="k8s.io/client-go@v0.33.3/tools/cache/reflector.go:285"
I0217 02:36:32.179316      13 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0217 02:36:32.179412      13 shared_informer.go:357] "Caches are synced" controller="RequestHeaderAuthRequestController"
I0217 02:36:32.179788      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:29:38 +0000 UTC to 2031-02-16 02:29:38 +0000 UTC (now=2026-02-17 02:36:32.179765535 +0000 UTC))"
I0217 02:36:32.180122      13 shared_informer.go:357] "Caches are synced" controller="client-ca::kube-system::extension-apiserver-authentication::requestheader-client-ca-file"
I0217 02:36:32.180485      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295790\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295789\" (2026-02-17 01:36:28 +0000 UTC to 2027-02-17 01:36:28 +0000 UTC (now=2026-02-17 02:36:32.18046747 +0000 UTC))"
I0217 02:36:32.181338      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295792\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295791\" (2026-02-17 01:36:31 +0000 UTC to 2029-02-17 01:36:31 +0000 UTC (now=2026-02-17 02:36:32.181168927 +0000 UTC))"
I0217 02:36:32.181436      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:29:38 +0000 UTC to 2031-02-16 02:29:38 +0000 UTC (now=2026-02-17 02:36:32.181424642 +0000 UTC))"
I0217 02:36:32.181779      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:29:40 +0000 UTC to 2031-02-16 02:29:40 +0000 UTC (now=2026-02-17 02:36:32.18176542 +0000 UTC))"
I0217 02:36:32.182520      13 tlsconfig.go:203] "Loaded serving cert" certName="Generated self signed cert" certDetail="\"localhost@1771295790\" [serving] validServingFor=[127.0.0.1,127.0.0.1,localhost] issuer=\"localhost-ca@1771295789\" (2026-02-17 01:36:28 +0000 UTC to 2027-02-17 01:36:28 +0000 UTC (now=2026-02-17 02:36:32.182505607 +0000 UTC))"
I0217 02:36:32.182874      13 named_certificates.go:53] "Loaded SNI cert" index=0 certName="self-signed loopback" certDetail="\"apiserver-loopback-client@1771295792\" [serving] validServingFor=[apiserver-loopback-client] issuer=\"apiserver-loopback-client-ca@1771295791\" (2026-02-17 01:36:31 +0000 UTC to 2029-02-17 01:36:31 +0000 UTC (now=2026-02-17 02:36:32.182860895 +0000 UTC))"
I0217 02:36:32.215462      13 node_controller.go:429] Initializing node kube-m89c8-default-worker-2kqk5-g55zp-z4jc8 with cloud provider
I0217 02:36:32.216841      13 node_controller.go:271] Update 3 nodes status took 1.496732ms.
I0217 02:36:32.218029      13 shared_informer.go:357] "Caches are synced" controller="service"
I0217 02:36:32.218906      13 controller.go:722] Syncing backends for all LB services.
I0217 02:36:32.219055      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:32.219417      13 controller.go:722] Syncing backends for all LB services.
I0217 02:36:32.219541      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:32.219564      13 controller.go:722] Syncing backends for all LB services.
I0217 02:36:32.219984      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:32.734736      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:36:32.735191      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:36:32.735475      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:36:32.735636      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:36:32.735693      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:36:32.736092      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:36:33.029097      13 controller.go:722] Syncing backends for all LB services.
I0217 02:36:33.029158      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:33.703421      13 node_controller.go:474] Successfully initialized node kube-m89c8-default-worker-2kqk5-g55zp-z4jc8 with cloud provider
I0217 02:36:33.704374      13 node_controller.go:429] Initializing node kube-m89c8-default-worker-2kqk5-g55zp-zd4zs with cloud provider
I0217 02:36:33.704928      13 event.go:389] "Event occurred" object="kube-m89c8-default-worker-2kqk5-g55zp-z4jc8" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:34.043387      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:36:34.043610      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:36:34.043662      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:36:34.044036      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:36:34.044204      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:36:34.044432      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:36:34.242645      13 controller.go:722] Syncing backends for all LB services.
I0217 02:36:34.243692      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:34.730909      13 node_controller.go:474] Successfully initialized node kube-m89c8-default-worker-2kqk5-g55zp-zd4zs with cloud provider
I0217 02:36:34.731019      13 node_controller.go:429] Initializing node kube-m89c8-mpmpl-wt7wn with cloud provider
I0217 02:36:34.731728      13 event.go:389] "Event occurred" object="kube-m89c8-default-worker-2kqk5-g55zp-zd4zs" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:36:35.365242      13 node_controller.go:512] Adding node label from cloud provider: beta.kubernetes.io/instance-type=m1.large
I0217 02:36:35.365328      13 node_controller.go:513] Adding node label from cloud provider: node.kubernetes.io/instance-type=m1.large
I0217 02:36:35.365336      13 node_controller.go:524] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/zone=nova
I0217 02:36:35.365342      13 node_controller.go:525] Adding node label from cloud provider: topology.kubernetes.io/zone=nova
I0217 02:36:35.365349      13 node_controller.go:535] Adding node label from cloud provider: failure-domain.beta.kubernetes.io/region=RegionOne
I0217 02:36:35.365355      13 node_controller.go:536] Adding node label from cloud provider: topology.kubernetes.io/region=RegionOne
I0217 02:36:35.573519      13 controller.go:722] Syncing backends for all LB services.
I0217 02:36:35.573770      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:36:35.771404      13 node_controller.go:474] Successfully initialized node kube-m89c8-mpmpl-wt7wn with cloud provider
I0217 02:36:35.772136      13 event.go:389] "Event occurred" object="kube-m89c8-mpmpl-wt7wn" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="Synced" message="Node synced successfully"
I0217 02:41:33.443008      13 node_controller.go:271] Update 3 nodes status took 1.22516231s.
I0217 02:46:34.493090      13 node_controller.go:271] Update 3 nodes status took 1.048904288s.
I0217 02:49:37.585216      13 controller.go:722] Syncing backends for all LB services.
I0217 02:49:37.594158      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:49:37.689432      13 controller.go:722] Syncing backends for all LB services.
I0217 02:49:37.689467      13 controller.go:726] Successfully updated 0 out of 0 load balancers to direct traffic to the updated set of nodes
I0217 02:51:35.640110      13 node_controller.go:271] Update 3 nodes status took 1.145840329s.
I0217 02:56:36.777786      13 node_controller.go:271] Update 3 nodes status took 1.136505041s.
I0217 03:01:37.882857      13 node_controller.go:271] Update 3 nodes status took 1.103688665s.
